Skip to content

Instantly share code, notes, and snippets.

@bobertrublik
Last active September 13, 2023 08:33
Show Gist options
  • Save bobertrublik/d770a62c64679db5b9eab5644f0cfebc to your computer and use it in GitHub Desktop.
Save bobertrublik/d770a62c64679db5b9eab5644f0cfebc to your computer and use it in GitHub Desktop.
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] No proxy settings were found based on environmental variables (http_proxy/https_proxy/HTTP_PROXY/HTTPS_PROXY)
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known config file 'Credentials': '/home/runner/.credentials'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known config file 'Runner': '/home/runner/.runner'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Adding extra user agent 'actions-runner-controller/0.5.0' to all HTTP requests.
[RUNNER 2023-09-12 09:05:07Z INFO Listener] Runner is built for Linux (X64) - linux-x64.
[RUNNER 2023-09-12 09:05:07Z INFO Listener] RuntimeInformation: Linux 5.15.0-1042-azure #49-Ubuntu SMP Tue Jul 11 17:28:46 UTC 2023.
[RUNNER 2023-09-12 09:05:07Z INFO Listener] Version: 2.309.0
[RUNNER 2023-09-12 09:05:07Z INFO Listener] Commit: ...
[RUNNER 2023-09-12 09:05:07Z INFO Listener] Culture:
[RUNNER 2023-09-12 09:05:07Z INFO Listener] UI Culture:
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:07Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:07Z INFO Listener] Validating directory permissions for: '/home/runner'
[RUNNER 2023-09-12 09:05:07Z INFO CommandLineParser] Parse
[RUNNER 2023-09-12 09:05:07Z INFO CommandLineParser] Parsing 1 args
[RUNNER 2023-09-12 09:05:07Z INFO CommandLineParser] parsing argument
[RUNNER 2023-09-12 09:05:07Z INFO CommandLineParser] HasArgs: False
[RUNNER 2023-09-12 09:05:07Z INFO CommandLineParser] Adding Command: run
[RUNNER 2023-09-12 09:05:07Z INFO CommandSettings] Removing env var: 'ACTIONS_RUNNER_INPUT_JITCONFIG'
[RUNNER 2023-09-12 09:05:07Z INFO Listener] Arguments parsed
[RUNNER 2023-09-12 09:05:08Z INFO Runner] ExecuteCommand
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] currentAssemblyLocation: /home/runner/bin/Runner.Listener.dll
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] binPath: /home/runner/bin
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] RootFolder: /home/runner
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known config file 'Runner': '/home/runner/.runner'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] ConfigFilePath: /home/runner/.runner
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known config file 'Credentials': '/home/runner/.credentials'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] CredFilePath: /home/runner/.credentials
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known config file 'MigratedCredentials': '/home/runner/.credentials_migrated'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] MigratedCredFilePath: /home/runner/.credentials_migrated
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known config file 'Service': '/home/runner/.service'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] ServiceConfigFilePath: /home/runner/.service
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Flag 'help': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Flag 'version': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Flag 'commit': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Flag 'check': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Command 'configure': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Command 'remove': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Command 'warmup': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Env arg 'jitconfig': '***'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO Runner] Saved 335 bytes to '/home/runner/.runner'.
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO Runner] Saved 216 bytes to '/home/runner/.credentials'.
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO Runner] Saved 1631 bytes to '/home/runner/.credentials_rsaparams'.
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] LoadSettings
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsConfigured()
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsConfigured: True
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] Is configured: True
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] Read setting file: 335 chars
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] Settings Loaded
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsServiceConfigured()
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsServiceConfigured: False
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Command 'run': 'True'
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsConfigured()
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsConfigured: True
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] Is configured: True
[RUNNER 2023-09-12 09:05:08Z INFO Runner] Could not parse the argument value '' for StartupType. Defaulting to Manual
[RUNNER 2023-09-12 09:05:08Z INFO Runner] Set runner startup type - Manual
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Flag 'once': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO CommandSettings] Flag 'once': 'False'
[RUNNER 2023-09-12 09:05:08Z INFO Runner] RunAsync
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] LoadSettings
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsConfigured()
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] IsConfigured: True
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] Is configured: True
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationManager] Settings Loaded
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] {
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "AgentId": 43,
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "AgentName": "github-runners-phzqn-runner-c6jmp",
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "PoolId": 4,
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "DisableUpdate": true,
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "Ephemeral": true,
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "ServerUrl": ".../",
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] "WorkFolder": "_work"
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] }
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] Loading Credentials
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] HasCredentials()
[RUNNER 2023-09-12 09:05:08Z INFO ConfigurationStore] stored True
[RUNNER 2023-09-12 09:05:08Z INFO CredentialManager] GetCredentialProvider
[RUNNER 2023-09-12 09:05:08Z INFO CredentialManager] Creating type OAuth
[RUNNER 2023-09-12 09:05:08Z INFO CredentialManager] Creating credential type: OAuth
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known directory 'Root': '/home/runner'
[RUNNER 2023-09-12 09:05:08Z INFO HostContext] Well known config file 'RSACredentials': '/home/runner/.credentials_rsaparams'
[RUNNER 2023-09-12 09:05:08Z INFO RSAFileKeyManager] Loading RSA key parameters from file /home/runner/.credentials_rsaparams
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] Attempt to create session.
[RUNNER 2023-09-12 09:05:08Z INFO MessageListener] Connecting to the Runner Server...
[RUNNER 2023-09-12 09:05:08Z INFO RunnerServer] EstablishVssConnection
[RUNNER 2023-09-12 09:05:08Z INFO RunnerServer] Establish connection with 100 seconds timeout.
[RUNNER 2023-09-12 09:05:08Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[RUNNER 2023-09-12 09:05:08Z INFO RunnerServer] EstablishVssConnection
[RUNNER 2023-09-12 09:05:08Z INFO RunnerServer] Establish connection with 60 seconds timeout.
[RUNNER 2023-09-12 09:05:08Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[RUNNER 2023-09-12 09:05:08Z INFO RunnerServer] EstablishVssConnection
[RUNNER 2023-09-12 09:05:08Z INFO RunnerServer] Establish connection with 60 seconds timeout.
[RUNNER 2023-09-12 09:05:08Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[RUNNER 2023-09-12 09:05:09Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[RUNNER 2023-09-12 09:05:09Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[RUNNER 2023-09-12 09:05:09Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[RUNNER 2023-09-12 09:05:10Z INFO MessageListener] VssConnection created
[RUNNER 2023-09-12 09:05:10Z INFO Terminal] WRITE LINE:
√ Connected to GitHub
[RUNNER 2023-09-12 09:05:10Z INFO Terminal] WRITE LINE:
[RUNNER 2023-09-12 09:05:10Z INFO RSAFileKeyManager] Loading RSA key parameters from file /home/runner/.credentials_rsaparams
[RUNNER 2023-09-12 09:05:10Z INFO RSAFileKeyManager] Loading RSA key parameters from file /home/runner/.credentials_rsaparams
[RUNNER 2023-09-12 09:05:10Z INFO GitHubActionsService] AAD Correlation ID for this token request: Unknown
[RUNNER 2023-09-12 09:05:10Z INFO MessageListener] Session created.
[RUNNER 2023-09-12 09:05:10Z INFO Terminal] WRITE LINE: Current runner version: '2.309.0'
Current runner version: '2.309.0'
[RUNNER 2023-09-12 09:05:10Z INFO Terminal] WRITE LINE: 2023-09-12 09:05:10Z: Listening for Jobs
2023-09-12 09:05:10Z: Listening for Jobs
[RUNNER 2023-09-12 09:05:10Z INFO JobDispatcher] Set runner/worker IPC timeout to 30 seconds.
[RUNNER 2023-09-12 09:07:33Z INFO RSAFileKeyManager] Loading RSA key parameters from file /home/runner/.credentials_rsaparams
[RUNNER 2023-09-12 09:07:33Z INFO MessageListener] Message '1' received from session '...'.
[RUNNER 2023-09-12 09:07:33Z INFO Runner] Received job message of length 25208 from service, with hash '...'
[RUNNER 2023-09-12 09:07:33Z INFO JobDispatcher] Job request 48941 for plan 6ce27e2b-fc3f-4fd3-a159-647e3205eb37 job ... received.
[RUNNER 2023-09-12 09:07:33Z INFO JobDispatcher] Pull OrchestrationId 6ce27e2b-fc3f-4fd3-a159-647e3205eb37.run.__default from JWT claims
[RUNNER 2023-09-12 09:07:33Z INFO JobDispatcher] Start dispatcher for one time used runner.
[RUNNER 2023-09-12 09:07:33Z INFO Terminal] WRITE LINE: 2023-09-12 09:07:33Z: Running job: run
2023-09-12 09:07:33Z: Running job: run
[RUNNER 2023-09-12 09:07:33Z INFO JobDispatcher] Start renew job request 48941 for job ....
[RUNNER 2023-09-12 09:07:33Z INFO Runner] One time used runner received job message.
[RUNNER 2023-09-12 09:07:33Z INFO JobDispatcher] Successfully renew job request 48941, job is valid till 09/12/2023 09:17:33
[RUNNER 2023-09-12 09:07:33Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Starting process:
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] File name: '/home/runner/bin/Runner.Worker'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Arguments: 'spawnclient 105 111'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Working directory: '/home/runner/bin'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Require exit code zero: 'False'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Encoding web name: ; code page: ''
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Force kill process on cancellation: 'True'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Redirected STDIN: 'False'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Persist current code page: 'False'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Keep redirected STDIN open: 'False'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] High priority process: 'True'
[RUNNER 2023-09-12 09:07:34Z INFO ProcessInvokerWrapper] Process started with process id 44, waiting for process exit.
[RUNNER 2023-09-12 09:07:34Z INFO JobDispatcher] Send job request message to worker for job ....
[RUNNER 2023-09-12 09:07:34Z INFO ProcessChannel] Sending message of length 25208, with hash '...'
[RUNNER 2023-09-12 09:07:34Z INFO JobNotification] Entering JobStarted Notification
[RUNNER 2023-09-12 09:07:34Z INFO JobNotification] Entering StartMonitor
[WORKER 2023-09-12 09:07:34Z INFO HostContext] No proxy settings were found based on environmental variables (http_proxy/https_proxy/HTTP_PROXY/HTTPS_PROXY)
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known config file 'Credentials': '/home/runner/.credentials'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known config file 'Runner': '/home/runner/.runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Adding extra user agent 'actions-runner-controller/0.5.0' to all HTTP requests.
[WORKER 2023-09-12 09:07:34Z INFO Worker] Version: 2.309.0
[WORKER 2023-09-12 09:07:34Z INFO Worker] Commit: ...
[WORKER 2023-09-12 09:07:34Z INFO Worker] Culture:
[WORKER 2023-09-12 09:07:34Z INFO Worker] UI Culture:
[WORKER 2023-09-12 09:07:34Z INFO Worker] Waiting to receive the job message from the channel.
[WORKER 2023-09-12 09:07:34Z INFO ProcessChannel] Receiving message of length 25208, with hash '...'
[WORKER 2023-09-12 09:07:34Z INFO Worker] Message received.
[WORKER 2023-09-12 09:07:34Z INFO Worker] Job message:
[WORKER 2023-09-12 09:07:34Z INFO Worker] {
...
[WORKER 2023-09-12 09:07:34Z INFO Worker] }
[WORKER 2023-09-12 09:07:34Z INFO JobRunner] Job ID ...
[WORKER 2023-09-12 09:07:34Z INFO JobRunner] Creating job server with URL: .../
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] currentAssemblyLocation: /home/runner/bin/Runner.Worker.dll
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] binPath: /home/runner/bin
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] RootFolder: /home/runner
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known config file 'Runner': '/home/runner/.runner'
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] ConfigFilePath: /home/runner/.runner
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known config file 'Credentials': '/home/runner/.credentials'
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] CredFilePath: /home/runner/.credentials
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known config file 'MigratedCredentials': '/home/runner/.credentials_migrated'
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] MigratedCredFilePath: /home/runner/.credentials_migrated
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:34Z INFO HostContext] Well known config file 'Service': '/home/runner/.service'
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] ServiceConfigFilePath: /home/runner/.service
[WORKER 2023-09-12 09:07:34Z INFO ConfigurationStore] Read setting file: 335 chars
[WORKER 2023-09-12 09:07:34Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[WORKER 2023-09-12 09:07:34Z INFO Worker] Listening for cancel message from the channel.
[WORKER 2023-09-12 09:07:34Z INFO Worker] Waiting for the job to complete or for a cancel message from the channel.
[WORKER 2023-09-12 09:07:35Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[WORKER 2023-09-12 09:07:36Z INFO JobServer] Creating websocket client ...wss://pipelines.actions.githubusercontent.com/lS7sSG8ZE9cv88GnzeoazwIjci6cZrGPi47lJcJ7IZdGty2PSF/00000000-0000-0000-0000-000000000000/_apis/distributedtask/hubs/Actions/plans/6ce27e2b-fc3f-4fd3-a159-647e3205eb37/timelines/6ce27e2b-fc3f-4fd3-a159-647e3205eb37/records/.../feedstream?api-version=6.0-preview
[WORKER 2023-09-12 09:07:36Z INFO JobServer] Attempting to start websocket client with delay 00:00:00.
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Initializing results client
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Start process web console line queue.
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Start process file upload queue.
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Start results file upload queue.
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Starting results-based upload queue...
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Start process timeline update queue.
[WORKER 2023-09-12 09:07:36Z INFO ExecutionContext] Initialize GitHub context
[WORKER 2023-09-12 09:07:36Z INFO ExecutionContext] Initialize Env context
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Diag': '/home/runner/_diag'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Diag': '/home/runner/_diag'
[WORKER 2023-09-12 09:07:36Z INFO JobRunner] Starting the job execution context.
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO JobRunner] Validating directory permissions for: '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Tools': '/home/runner/_work/_tool'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Temp': '/home/runner/_work/_temp'
[WORKER 2023-09-12 09:07:36Z INFO JobRunner] Getting job extension.
[WORKER 2023-09-12 09:07:36Z INFO JobRunner] Initialize job. Getting all job steps.
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Diag': '/home/runner/_diag'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Diag': '/home/runner/_diag'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known config file 'Credentials': '/home/runner/.credentials'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known config file 'SetupInfo': '/home/runner/.setup_info'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO PipelineDirectoryManager] Loading tracking config if exists: /home/runner/_work/_PipelineMapping/private/privaterepo/PipelineFolder.json
[WORKER 2023-09-12 09:07:36Z INFO PipelineDirectoryManager] Creating a new tracking config file.
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO PipelineDirectoryManager] Creating pipeline directory.
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO PipelineDirectoryManager] Creating workspace directory.
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Tools': '/home/runner/_work/_tool'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Externals': '/home/runner/externals'
[WORKER 2023-09-12 09:07:36Z INFO JobExtension] Downloading actions
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Actions': '/home/runner/_work/_actions'
[WORKER 2023-09-12 09:07:36Z INFO JobServer] Successfully started websocket client.
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Try to append 1 batches web console lines for record '...', success rate: 1/1.
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Actions': '/home/runner/_work/_actions'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:36Z INFO HostContext] Well known directory 'Actions': '/home/runner/_work/_actions'
[WORKER 2023-09-12 09:07:36Z INFO ActionManager] Save archive 'https://api.github.com/repos/actions/checkout/tarball/f43a0e5ff2bd294095638e18286ca9a3d1956744' into /home/runner/_work/_actions/_temp_d4b26ebe-fab1-4ec8-8965-8a51fd7c34ad/a5bcc473-5316-4a24-9eb6-a080ffd542bb.tar.gz.
[WORKER 2023-09-12 09:07:36Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'ad60f0f9-2fdf-4fdd-8516-75b58899884b', success rate: 1/1.
[WORKER 2023-09-12 09:07:37Z INFO ActionManager] Request URL: https://api.github.com/repos/actions/checkout/tarball/f43a0e5ff2bd294095638e18286ca9a3d1956744 X-GitHub-Request-Id: 0C80:0DBF:48269A:52684A:65002A59 Http Status: OK
[WORKER 2023-09-12 09:07:37Z INFO ActionManager] Which: 'tar'
[WORKER 2023-09-12 09:07:37Z INFO ActionManager] Location: '/usr/bin/tar'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Starting process:
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] File name: '/usr/bin/tar'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Arguments: '-xzf "/home/runner/_work/_actions/_temp_d4b26ebe-fab1-4ec8-8965-8a51fd7c34ad/a5bcc473-5316-4a24-9eb6-a080ffd542bb.tar.gz"'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Working directory: '/home/runner/_work/_actions/_temp_d4b26ebe-fab1-4ec8-8965-8a51fd7c34ad/_staging'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Require exit code zero: 'False'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Encoding web name: ; code page: ''
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Force kill process on cancellation: 'False'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Redirected STDIN: 'False'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Persist current code page: 'False'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Keep redirected STDIN open: 'False'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] High priority process: 'False'
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Failed to update oom_score_adj for PID: 65.
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] System.UnauthorizedAccessException: Access to the path '/proc/65/oom_score_adj' is denied.
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] ---> System.IO.IOException: Permission denied
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] --- End of inner exception stack trace ---
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.RandomAccess.WriteAtOffset(SafeFileHandle handle, ReadOnlySpan`1 buffer, Int64 fileOffset)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.Strategies.OSFileStreamStrategy.Write(ReadOnlySpan`1 buffer)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.Flush(Boolean flushToDisk)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.CloseStreamFromDispose(Boolean disposing)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at System.IO.File.WriteAllText(String path, String contents)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] at GitHub.Runner.Sdk.ProcessInvoker.WriteProcessOomScoreAdj(Int32 processId, Int32 oomScoreAdj)
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Process started with process id 65, waiting for process exit.
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[WORKER 2023-09-12 09:07:37Z INFO ProcessInvokerWrapper] Finished process 65 with exit code 0, and elapsed time 00:00:00.0303834.
[WORKER 2023-09-12 09:07:37Z INFO JobServerQueue] Job timeline record has been updated for the first time.
[WORKER 2023-09-12 09:07:37Z INFO ActionManager] Finished getting action repository.
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Actions': '/home/runner/_work/_actions'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:37Z INFO HostContext] Well known directory 'Actions': '/home/runner/_work/_actions'
[WORKER 2023-09-12 09:07:37Z INFO ActionManager] Save archive 'https://api.github.com/repos/LouisBrunner/checks-action/tarball/9a0aa980f3bfa365788965ed309f7f0090cfcf29' into /home/runner/_work/_actions/_temp_8da1db66-057b-4eec-82dc-a1f93ef783e4/fa95b67f-4af0-47a2-aca0-dda3adde1260.tar.gz.
[WORKER 2023-09-12 09:07:37Z INFO JobServerQueue] Try to append 1 batches web console lines for record '...', success rate: 1/1.
[WORKER 2023-09-12 09:07:38Z INFO ActionManager] Request URL: https://api.github.com/repos/LouisBrunner/checks-action/tarball/9a0aa980f3bfa365788965ed309f7f0090cfcf29 X-GitHub-Request-Id: 0C81:13FC9:5053E2:5A95F9:65002A59 Http Status: OK
[WORKER 2023-09-12 09:07:38Z INFO ActionManager] Which: 'tar'
[WORKER 2023-09-12 09:07:38Z INFO ActionManager] Location: '/usr/bin/tar'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Starting process:
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] File name: '/usr/bin/tar'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Arguments: '-xzf "/home/runner/_work/_actions/_temp_8da1db66-057b-4eec-82dc-a1f93ef783e4/fa95b67f-4af0-47a2-aca0-dda3adde1260.tar.gz"'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Working directory: '/home/runner/_work/_actions/_temp_8da1db66-057b-4eec-82dc-a1f93ef783e4/_staging'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Require exit code zero: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Encoding web name: ; code page: ''
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Force kill process on cancellation: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Redirected STDIN: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Persist current code page: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Keep redirected STDIN open: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] High priority process: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Failed to update oom_score_adj for PID: 71.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] System.UnauthorizedAccessException: Access to the path '/proc/71/oom_score_adj' is denied.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] ---> System.IO.IOException: Permission denied
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] --- End of inner exception stack trace ---
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.RandomAccess.WriteAtOffset(SafeFileHandle handle, ReadOnlySpan`1 buffer, Int64 fileOffset)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.Strategies.OSFileStreamStrategy.Write(ReadOnlySpan`1 buffer)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.FlushWrite()
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.CloseStreamFromDispose(Boolean disposing)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.File.WriteAllText(String path, String contents)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at GitHub.Runner.Sdk.ProcessInvoker.WriteProcessOomScoreAdj(Int32 processId, Int32 oomScoreAdj)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Process started with process id 71, waiting for process exit.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Finished process 71 with exit code 0, and elapsed time 00:00:00.0101974.
[WORKER 2023-09-12 09:07:38Z INFO ActionManager] Finished getting action repository.
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Externals': '/home/runner/externals'
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Getting extensions for interface: 'GitHub.Runner.Worker.IActionCommandExtension'
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.InternalPluginSetRepoPathCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.SetEnvCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.SetOutputCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.SaveStateCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.AddPathCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.AddMaskCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.AddMatcherCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.RemoveMatcherCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.WarningCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.ErrorCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.NoticeCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.DebugCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.GroupCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.EndGroupCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ExtensionManager] Creating instance: GitHub.Runner.Worker.EchoCommandExtension, Runner.Worker
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command internal-set-repo-path
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command set-env
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command set-output
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command save-state
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command add-path
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command add-mask
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command add-matcher
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command remove-matcher
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command warning
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command error
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command notice
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command debug
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command group
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command endgroup
[WORKER 2023-09-12 09:07:38Z INFO ActionCommandManager] Register action command extension for command echo
[WORKER 2023-09-12 09:07:38Z INFO ScriptHandler] Which: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:38Z INFO ScriptHandler] Fully qualified path: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:38Z INFO HostContext] Well known directory 'Temp': '/home/runner/_work/_temp'
[WORKER 2023-09-12 09:07:38Z INFO ScriptHandler] Which: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:38Z INFO ScriptHandler] Fully qualified path: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Starting process:
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] File name: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Arguments: '/home/runner/k8s/index.js'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Working directory: '/home/runner/_work/privaterepo/privaterepo'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Require exit code zero: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Encoding web name: ; code page: ''
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Force kill process on cancellation: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Redirected STDIN: 'True'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Persist current code page: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Keep redirected STDIN open: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] High priority process: 'False'
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Failed to update oom_score_adj for PID: 73.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] System.UnauthorizedAccessException: Access to the path '/proc/73/oom_score_adj' is denied.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] ---> System.IO.IOException: Permission denied
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] --- End of inner exception stack trace ---
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.RandomAccess.WriteAtOffset(SafeFileHandle handle, ReadOnlySpan`1 buffer, Int64 fileOffset)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.Strategies.OSFileStreamStrategy.Write(ReadOnlySpan`1 buffer)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.FlushWrite()
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.CloseStreamFromDispose(Boolean disposing)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at System.IO.File.WriteAllText(String path, String contents)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] at GitHub.Runner.Sdk.ProcessInvoker.WriteProcessOomScoreAdj(Int32 processId, Int32 oomScoreAdj)
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Process started with process id 73, waiting for process exit.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] Close STDIN after the first redirect finished.
[WORKER 2023-09-12 09:07:38Z INFO ProcessInvokerWrapper] STDIN stream write finished.
[WORKER 2023-09-12 09:07:55Z INFO ActionManifestManager] Input 'github-server-url': default value evaluate result: ""
[WORKER 2023-09-12 09:07:55Z INFO ExtensionManager] Getting extensions for interface: 'GitHub.Runner.Worker.IActionCommandExtension'
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command internal-set-repo-path
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command set-env
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command set-output
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command save-state
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command add-path
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command add-mask
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command add-matcher
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command remove-matcher
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command warning
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command error
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command notice
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command debug
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command group
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command endgroup
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command echo
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Externals': '/home/runner/externals'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Temp': '/home/runner/_work/_temp'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Externals': '/home/runner/externals'
[WORKER 2023-09-12 09:07:55Z INFO ExtensionManager] Getting extensions for interface: 'GitHub.Runner.Worker.IActionCommandExtension'
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command internal-set-repo-path
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command set-env
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command set-output
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command save-state
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command add-path
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command add-mask
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command add-matcher
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command remove-matcher
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command warning
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command error
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command notice
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command debug
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command group
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command endgroup
[WORKER 2023-09-12 09:07:55Z INFO ActionCommandManager] Register action command extension for command echo
[WORKER 2023-09-12 09:07:55Z INFO ScriptHandler] Which: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:55Z INFO ScriptHandler] Fully qualified path: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Bin': '/home/runner/bin'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Root': '/home/runner'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Work': '/home/runner/_work'
[WORKER 2023-09-12 09:07:55Z INFO HostContext] Well known directory 'Temp': '/home/runner/_work/_temp'
[WORKER 2023-09-12 09:07:55Z INFO ScriptHandler] Which: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:55Z INFO ScriptHandler] Fully qualified path: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Starting process:
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] File name: '/home/runner/externals/node16/bin/node'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Arguments: '/home/runner/k8s/index.js'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Working directory: '/home/runner/_work/private/privaterepo'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Require exit code zero: 'False'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Encoding web name: ; code page: ''
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Force kill process on cancellation: 'False'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Redirected STDIN: 'True'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Persist current code page: 'False'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Keep redirected STDIN open: 'False'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] High priority process: 'False'
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Failed to update oom_score_adj for PID: 104.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] System.UnauthorizedAccessException: Access to the path '/proc/104/oom_score_adj' is denied.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] ---> System.IO.IOException: Permission denied
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] --- End of inner exception stack trace ---
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at System.IO.RandomAccess.WriteAtOffset(SafeFileHandle handle, ReadOnlySpan`1 buffer, Int64 fileOffset)
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.FlushWrite()
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at System.IO.Strategies.BufferedFileStreamStrategy.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.CloseStreamFromDispose(Boolean disposing)
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at System.IO.StreamWriter.Dispose(Boolean disposing)
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at System.IO.File.WriteAllText(String path, String contents)
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] at GitHub.Runner.Sdk.ProcessInvoker.WriteProcessOomScoreAdj(Int32 processId, Int32 oomScoreAdj)
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Process started with process id 104, waiting for process exit.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Close STDIN after the first redirect finished.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] STDIN stream write finished.
[WORKER 2023-09-12 09:07:55Z INFO JobServerQueue] Try to append 1 batches web console lines for record '687b6874-da2a-5645-e88b-359d0aae4e9f', success rate: 1/1.
[WORKER 2023-09-12 09:07:55Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'b04ad9a4-5a1e-4b19-81ac-03dc7aeb4f18', success rate: 1/1.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[WORKER 2023-09-12 09:07:55Z INFO ProcessInvokerWrapper] Finished process 104 with exit code 1, and elapsed time 00:00:00.5197692.
[WORKER 2023-09-12 09:07:55Z INFO CreateStepSummaryCommand] Step Summary file (/home/runner/_work/_temp/_runner_file_commands/step_summary_fb68f274-94df-4352-bec2-14eda695673e) is empty; skipping attachment upload
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] Caught exception from step: System.Exception: Executing the custom container implementation failed. Please contact your self hosted runner administrator.
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] ---> System.Exception: The hook script at '/home/runner/k8s/index.js' running command 'RunScriptStep' did not execute successfully
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.Container.ContainerHooks.ContainerHookManager.ExecuteHookScript[T](IExecutionContext context, HookInput input, ActionRunStage stage, String prependPath)
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] --- End of inner exception stack trace ---
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.Container.ContainerHooks.ContainerHookManager.ExecuteHookScript[T](IExecutionContext context, HookInput input, ActionRunStage stage, String prependPath)
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.Container.ContainerHooks.ContainerHookManager.RunScriptStepAsync(IExecutionContext context, ContainerInfo container, String workingDirectory, String entryPoint, String entryPointArgs, IDictionary`2 environmentVariables, String prependPath)
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.Handlers.ContainerStepHost.ExecuteAsync(IExecutionContext context, String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, Boolean inheritConsoleHandler, String standardInInput, CancellationToken cancellationToken)
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.Handlers.NodeScriptActionHandler.RunAsync(ActionRunStage stage)
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.ActionRunner.RunAsync()
[WORKER 2023-09-12 09:07:55Z ERR StepsRunner] at GitHub.Runner.Worker.StepsRunner.RunStepAsync(IStep step, CancellationToken jobCancellationToken)
[WORKER 2023-09-12 09:07:55Z INFO StepsRunner] Step result: Failed
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] Publish step telemetry for current step {
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "action": "Pre Job Hook",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "ref": "v3",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "type": "runner",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "stage": "Post",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "stepId": "b04ad9a4-5a1e-4b19-81ac-03dc7aeb4f18",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "result": "failed",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "errorMessages": [
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "Error: failed to run script step: command terminated with non-zero exit code: error executing command [sh -e /__w/_temp/dc448860-514b-11ee-bddd-0d3273f56088.sh], exit code 1",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "Process completed with exit code 1.",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "Executing the custom container implementation failed. Please contact your self hosted runner administrator."
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] ],
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "executionTimeInSeconds": 1,
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "startTime": "2023-09-12T09:07:55.1047181Z",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "finishTime": "2023-09-12T09:07:55.6592229Z",
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] "containerHookData": "{\"hookScriptPath\":\"/home/runner/k8s/index.js\"}"
[WORKER 2023-09-12 09:07:55Z INFO ExecutionContext] }.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment