Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Runner REST API returns a runner as offline, but jobs getting scheduled on it #3448

Open
likhith-reddy-glean opened this issue Sep 2, 2024 · 0 comments
Open

Runner REST API returns a runner as offline, but jobs getting scheduled on it #3448

likhith-reddy-glean opened this issue Sep 2, 2024 · 0 comments
Labels
bug Something isn't working

Comments

@likhith-reddy-glean
Copy link

Describe the bug
When runners use svc.sh to run the self-hosted runner application as a service and enter a sleep state for an extended period (around 5-6 hours) after getting connected to Github once, they encounter an issue upon reconnecting. Although the logs indicate that the runner is connected, the REST API for runners reports it as offline. Conversely, if the sleep duration is shorter (around 10-15 minutes), the runner reconnects successfully, and GitHub displays it as online. Additionally, GitHub schedules workflow runs on these machines which got reconnected and are shown as offline in both the UI and REST API. The runner is able to pick up the job, since it is reconnected to Github, but the runner REST API is returning it as offline.

To Reproduce
Steps to reproduce the behavior:

  1. Start a self-hosted runner with runner application as a service. Github UI, Rest API shows online runner.
  2. Move the runner to sleep for sometime (around 5-6 hours). Github UI, Rest API shows runner to be offline.
  3. Take it out of sleep, runner reconnects to Github. Github UI, Rest API shows runner to be offline. Github schedules runs on that runner. The runner runs the workflow.

Expected behavior
The runner status should be returned as online when the runner gets reconnected to Github.

Runner Version and Platform

v2.319.1

OS of the machine running the runner? OSX/Windows/Linux/...
Linux

What's not working?

Please include error messages and screenshots.
On running ./svc.sh status

Loaded: loaded (/etc/systemd/system/actions.runner.repo.test-runner.service; enabled; vendor preset: enabled)
     Active: active (running) since Sun 2024-09-01 20:42:04 UTC; 8h ago
   Main PID: 40610 (runsvc.sh)
      Tasks: 20 (limit: 154548)
     Memory: 1.8G
        CPU: 4min 53.645s
     CGroup: /system.slice/actions.runner.repo.test-runner.service
             ├─40610 /bin/bash /opt/gha/runsvc.sh
             ├─40614 ./externals/node16/bin/node ./bin/RunnerService.js
             └─40642 /opt/gha/bin/Runner.Listener run --startuptype service

Sep 01 20:42:04 test-runner ci-agent[40614]: Starting Runner listener with startup type: service
Sep 01 20:42:04 test-runner ci-agent[40614]: Started listener process, pid: 40642
Sep 01 20:42:04 test-runner ci-agent[40614]: Started running service
Sep 01 20:42:06 test-runner ci-agent[40614]: √ Connected to GitHub
Sep 01 20:42:07 test-runner ci-agent[40614]: Current runner version: '2.319.1'
Sep 01 20:42:07 test-runner ci-agent[40614]: 2024-09-01 20:42:07Z: Listening for Jobs
Sep 02 04:44:15 test-runner ci-agent[40614]: 2024-09-02 04:44:13Z: Runner connect error: The HTTP request timed out after …nnected.
Sep 02 04:45:51 test-runner ci-agent[40614]: 2024-09-02 04:45:51Z: Runner reconnected.
Sep 02 05:10:28 test-runner ci-agent[40614]: 2024-09-02 05:10:28Z: Running job: Test workflow
Sep 02 05:19:40 test-runner ci-agent[40614]: 2024-09-02 05:19:40Z: Job Test workflow completed with result: Succeeded

test-runner is offline from runner REST API, but workflow run got scheduled on the runner by Github.

Job Log Output

Runner and Worker's Diagnostic Logs

Runner _diag log

[2024-09-01 20:42:05Z INFO Listener] Runner is built for Linux (X64) - linux-x64.
[2024-09-01 20:42:05Z INFO Listener] RuntimeInformation: Linux 6.5.0-1025-gcp #27~22.04.1-Ubuntu SMP Tue Jul 16 23:03:39 UTC 2024.
[2024-09-01 20:42:05Z INFO Listener] Version: 2.319.1
[2024-09-01 20:42:05Z INFO Listener] Culture: 
[2024-09-01 20:42:05Z INFO Listener] UI Culture: 
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO Listener] Validating directory permissions for: '/opt/gha'
[2024-09-01 20:42:05Z INFO CommandLineParser] Parse
[2024-09-01 20:42:05Z INFO CommandLineParser] Parsing 3 args
[2024-09-01 20:42:05Z INFO CommandLineParser] parsing argument
[2024-09-01 20:42:05Z INFO CommandLineParser] HasArgs: False
[2024-09-01 20:42:05Z INFO CommandLineParser] Adding Command: run
[2024-09-01 20:42:05Z INFO CommandLineParser] parsing argument
[2024-09-01 20:42:05Z INFO CommandLineParser] HasArgs: True
[2024-09-01 20:42:05Z INFO CommandLineParser] arg: startuptype
[2024-09-01 20:42:05Z INFO CommandLineParser] parsing argument
[2024-09-01 20:42:05Z INFO CommandLineParser] HasArgs: True
[2024-09-01 20:42:05Z INFO CommandLineParser] Adding option 'startuptype': 'service'
[2024-09-01 20:42:05Z INFO Listener] Arguments parsed
[2024-09-01 20:42:05Z INFO Runner] ExecuteCommand
[2024-09-01 20:42:05Z INFO ConfigurationStore] currentAssemblyLocation: /opt/gha/bin/Runner.Listener.dll
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO ConfigurationStore] binPath: /opt/gha/bin
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO ConfigurationStore] RootFolder: /opt/gha
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO HostContext] Well known config file 'Runner': '/opt/gha/.runner'
[2024-09-01 20:42:05Z INFO ConfigurationStore] ConfigFilePath: /opt/gha/.runner
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO HostContext] Well known config file 'Credentials': '/opt/gha/.credentials'
[2024-09-01 20:42:05Z INFO ConfigurationStore] CredFilePath: /opt/gha/.credentials
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO HostContext] Well known config file 'MigratedCredentials': '/opt/gha/.credentials_migrated'
[2024-09-01 20:42:05Z INFO ConfigurationStore] MigratedCredFilePath: /opt/gha/.credentials_migrated
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO HostContext] Well known config file 'Service': '/opt/gha/.service'
[2024-09-01 20:42:05Z INFO ConfigurationStore] ServiceConfigFilePath: /opt/gha/.service
[2024-09-01 20:42:05Z INFO CommandSettings] Flag 'help': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Flag 'version': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Flag 'commit': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Flag 'check': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Command 'configure': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Command 'remove': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Command 'warmup': 'False'
[2024-09-01 20:42:05Z INFO ConfigurationManager] LoadSettings
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsConfigured()
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsConfigured: True
[2024-09-01 20:42:05Z INFO ConfigurationManager] Is configured: True
[2024-09-01 20:42:05Z INFO ConfigurationStore] Read setting file: 356 chars
[2024-09-01 20:42:05Z INFO ConfigurationManager] Settings Loaded
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsServiceConfigured()
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsServiceConfigured: True
[2024-09-01 20:42:05Z INFO CommandSettings] Command 'run': 'True'
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsConfigured()
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsConfigured: True
[2024-09-01 20:42:05Z INFO ConfigurationManager] Is configured: True
[2024-09-01 20:42:05Z INFO Runner] Set runner startup type - Service
[2024-09-01 20:42:05Z INFO CommandSettings] Flag 'once': 'False'
[2024-09-01 20:42:05Z INFO CommandSettings] Flag 'once': 'False'
[2024-09-01 20:42:05Z INFO Runner] RunAsync
[2024-09-01 20:42:05Z INFO ConfigurationManager] LoadSettings
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsConfigured()
[2024-09-01 20:42:05Z INFO ConfigurationStore] IsConfigured: True
[2024-09-01 20:42:05Z INFO ConfigurationManager] Is configured: True
[2024-09-01 20:42:05Z INFO ConfigurationManager] Settings Loaded
[2024-09-01 20:42:05Z INFO MessageListener] {
  "AgentId": <id>,
  "AgentName": "test-runner",
  "PoolId": 1,
  "PoolName": "Default",
  "DisableUpdate": true,
  "ServerUrl": "<url>",
  "GitHubUrl": "https://github.com/org/repo",
  "WorkFolder": "/workdir"
}
[2024-09-01 20:42:05Z INFO MessageListener] Loading Credentials
[2024-09-01 20:42:05Z INFO ConfigurationStore] HasCredentials()
[2024-09-01 20:42:05Z INFO ConfigurationStore] stored True
[2024-09-01 20:42:05Z INFO CredentialManager] GetCredentialProvider
[2024-09-01 20:42:05Z INFO CredentialManager] Creating type OAuth
[2024-09-01 20:42:05Z INFO CredentialManager] Creating credential type: OAuth
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-01 20:42:05Z INFO HostContext] Well known directory 'Root': '/opt/gha'
[2024-09-01 20:42:05Z INFO HostContext] Well known config file 'RSACredentials': '/opt/gha/.credentials_rsaparams'
[2024-09-01 20:42:05Z INFO RSAFileKeyManager] Loading RSA key parameters from file /opt/gha/.credentials_rsaparams
[2024-09-01 20:42:05Z INFO MessageListener] Attempt to create session.
[2024-09-01 20:42:05Z INFO MessageListener] Connecting to the Runner Server...
[2024-09-01 20:42:05Z INFO RunnerServer] EstablishVssConnection
[2024-09-01 20:42:05Z INFO RunnerServer] Establish connection with 100 seconds timeout.
[2024-09-01 20:42:05Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[2024-09-01 20:42:05Z INFO RunnerServer] EstablishVssConnection
[2024-09-01 20:42:05Z INFO RunnerServer] Establish connection with 60 seconds timeout.
[2024-09-01 20:42:05Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[2024-09-01 20:42:05Z INFO RunnerServer] EstablishVssConnection
[2024-09-01 20:42:05Z INFO RunnerServer] Establish connection with 60 seconds timeout.
[2024-09-01 20:42:05Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[2024-09-01 20:42:05Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[2024-09-01 20:42:05Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[2024-09-01 20:42:05Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[2024-09-01 20:42:06Z INFO MessageListener] VssConnection created
[2024-09-01 20:42:06Z INFO Terminal] WRITE LINE: 
[2024-09-01 20:42:06Z INFO Terminal] WRITE LINE: 
[2024-09-01 20:42:06Z INFO RSAFileKeyManager] Loading RSA key parameters from file /opt/gha/.credentials_rsaparams
[2024-09-01 20:42:06Z INFO RSAFileKeyManager] Loading RSA key parameters from file /opt/gha/.credentials_rsaparams
[2024-09-01 20:42:06Z INFO GitHubActionsService] AAD Correlation ID for this token request: Unknown
[2024-09-01 20:42:07Z INFO MessageListener] Session created.
[2024-09-01 20:42:07Z INFO Terminal] WRITE LINE: Current runner version: '2.319.1'
[2024-09-01 20:42:07Z INFO Terminal] WRITE LINE: 2024-09-01 20:42:07Z: Listening for Jobs
[2024-09-01 20:42:07Z INFO JobDispatcher] Set runner/worker IPC timeout to 30 seconds.
[2024-09-02 04:44:12Z WARN GitHubActionsService] GET request to <url>&disableUpdate=true timed out after 60 seconds.
[2024-09-02 04:44:12Z ERR  MessageListener] Catch exception during get next message.
[2024-09-02 04:44:13Z ERR  MessageListener] System.TimeoutException: The HTTP request timed out after 00:01:00.
 ---> System.Threading.Tasks.TaskCanceledException: The operation was canceled.
 ---> System.IO.IOException: Unable to read data from the transport connection: Operation canceled.
 ---> System.Net.Sockets.SocketException (125): Operation canceled
   --- End of inner exception stack trace ---
   at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
   at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
   at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](TIOAdapter adapter)
   at System.Net.Security.SslStream.ReadAsyncInternal[TIOAdapter](TIOAdapter adapter, Memory`1 buffer)
   at System.Net.Http.HttpConnection.SendAsyncCore(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
   --- End of inner exception stack trace ---
   at System.Net.Http.HttpConnection.SendAsyncCore(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
   at System.Net.Http.AuthenticationHelper.SendWithNtAuthAsync(HttpRequestMessage request, Uri authUri, Boolean async, ICredentials credentials, Boolean isProxyAuth, HttpConnection connection, HttpConnectionPool connectionPool, CancellationToken cancellationToken)
   at System.Net.Http.HttpConnectionPool.SendWithVersionDetectionAndRetryAsync(HttpRequestMessage request, Boolean async, Boolean doRequestAuth, CancellationToken cancellationToken)
   at System.Net.Http.AuthenticationHelper.SendWithAuthAsync(HttpRequestMessage request, Uri authUri, Boolean async, ICredentials credentials, Boolean preAuthenticate, Boolean isProxyAuth, Boolean doRequestAuth, HttpConnectionPool pool, CancellationToken cancellationToken)
   at System.Net.Http.DecompressionHandler.SendAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
   at GitHub.Services.Common.VssHttpMessageHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
   --- End of inner exception stack trace ---
   at GitHub.Services.Common.VssHttpMessageHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
   at GitHub.Services.Common.VssHttpRetryMessageHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
   at System.Net.Http.HttpClient.<SendAsync>g__Core|83_0(HttpRequestMessage request, HttpCompletionOption completionOption, CancellationTokenSource cts, Boolean disposeCts, CancellationTokenSource pendingRequestsCts, CancellationToken originalCancellationToken)
   at GitHub.Services.WebApi.VssHttpClientBase.SendAsync(HttpRequestMessage message, HttpCompletionOption completionOption, Object userState, CancellationToken cancellationToken)
   at GitHub.Services.WebApi.VssHttpClientBase.SendAsync[T](HttpRequestMessage message, Object userState, CancellationToken cancellationToken)
   at GitHub.Services.WebApi.VssHttpClientBase.SendAsync[T](HttpMethod method, IEnumerable`1 additionalHeaders, Guid locationId, Object routeValues, ApiResourceVersion version, HttpContent content, IEnumerable`1 queryParameters, Object userState, CancellationToken cancellationToken)
   at GitHub.Runner.Listener.MessageListener.GetNextMessageAsync(CancellationToken token)
[2024-09-02 04:44:13Z ERR  MessageListener] #####################################################
[2024-09-02 04:44:13Z ERR  MessageListener] System.Threading.Tasks.TaskCanceledException: The operation was canceled.
 ---> System.IO.IOException: Unable to read data from the transport connection: Operation canceled.
 ---> System.Net.Sockets.SocketException (125): Operation canceled
   --- End of inner exception stack trace ---
   at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
   at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
   at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](TIOAdapter adapter)
   at System.Net.Security.SslStream.ReadAsyncInternal[TIOAdapter](TIOAdapter adapter, Memory`1 buffer)
   at System.Net.Http.HttpConnection.SendAsyncCore(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
   --- End of inner exception stack trace ---
   at System.Net.Http.HttpConnection.SendAsyncCore(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
   at System.Net.Http.AuthenticationHelper.SendWithNtAuthAsync(HttpRequestMessage request, Uri authUri, Boolean async, ICredentials credentials, Boolean isProxyAuth, HttpConnection connection, HttpConnectionPool connectionPool, CancellationToken cancellationToken)
   at System.Net.Http.HttpConnectionPool.SendWithVersionDetectionAndRetryAsync(HttpRequestMessage request, Boolean async, Boolean doRequestAuth, CancellationToken cancellationToken)
   at System.Net.Http.AuthenticationHelper.SendWithAuthAsync(HttpRequestMessage request, Uri authUri, Boolean async, ICredentials credentials, Boolean preAuthenticate, Boolean isProxyAuth, Boolean doRequestAuth, HttpConnectionPool pool, CancellationToken cancellationToken)
   at System.Net.Http.DecompressionHandler.SendAsync(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
   at GitHub.Services.Common.VssHttpMessageHandler.SendAsync(HttpRequestMessage request, CancellationToken cancellationToken)
[2024-09-02 04:44:13Z ERR  MessageListener] #####################################################
[2024-09-02 04:44:13Z ERR  MessageListener] System.IO.IOException: Unable to read data from the transport connection: Operation canceled.
 ---> System.Net.Sockets.SocketException (125): Operation canceled
   --- End of inner exception stack trace ---
   at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
   at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
   at System.Net.Security.SslStream.EnsureFullTlsFrameAsync[TIOAdapter](TIOAdapter adapter)
   at System.Net.Security.SslStream.ReadAsyncInternal[TIOAdapter](TIOAdapter adapter, Memory`1 buffer)
   at System.Net.Http.HttpConnection.SendAsyncCore(HttpRequestMessage request, Boolean async, CancellationToken cancellationToken)
[2024-09-02 04:44:13Z ERR  MessageListener] #####################################################
[2024-09-02 04:44:13Z ERR  MessageListener] System.Net.Sockets.SocketException (125): Operation canceled
[2024-09-02 04:44:13Z INFO MessageListener] Retriable exception: The HTTP request timed out after 00:01:00.
[2024-09-02 04:44:13Z ERR  Terminal] WRITE ERROR: 2024-09-02 04:44:13Z: Runner connect error: The HTTP request timed out after 00:01:00.. Retrying until reconnected.
[2024-09-02 04:44:13Z INFO RunnerServer] Refresh MessageQueue VssConnection to get on a different AFD node.
[2024-09-02 04:44:13Z INFO RunnerServer] EstablishVssConnection
[2024-09-02 04:44:13Z INFO RunnerServer] Establish connection with 60 seconds timeout.
[2024-09-02 04:44:14Z INFO GitHubActionsService] Starting operation Location.GetConnectionData
[2024-09-02 04:44:14Z WARN GitHubActionsService] Attempt 1 of GET request to <url> failed (Socket Error: TryAgain). The operation will be retried in 11.071 seconds.
[2024-09-02 04:44:34Z INFO GitHubActionsService] Finished operation Location.GetConnectionData
[2024-09-02 04:44:35Z INFO MessageListener] Sleeping for 25.893 seconds before retrying.
[2024-09-02 04:45:01Z INFO RSAFileKeyManager] Loading RSA key parameters from file /opt/gha/.credentials_rsaparams
[2024-09-02 04:45:01Z INFO GitHubActionsService] AAD Correlation ID for this token request: Unknown
[2024-09-02 04:45:51Z INFO Terminal] WRITE LINE: 2024-09-02 04:45:51Z: Runner reconnected.
[2024-09-02 05:10:27Z INFO RSAFileKeyManager] Loading RSA key parameters from file /opt/gha/.credentials_rsaparams
[2024-09-02 05:10:27Z INFO MessageListener] Message '1' received from session 'session_id'.
[2024-09-02 05:10:27Z INFO Runner] Received job message of length 36604 from service, with hash '49b33ef190a0318b9cffe0580968c6b769218950451302f086c26e5b50f93dea'
[2024-09-02 05:10:28Z INFO JobDispatcher] Job request 581691 for plan id job jon_id received.
[2024-09-02 05:10:28Z INFO JobDispatcher] Pull OrchestrationId id.test-workflow.__default from JWT claims
[2024-09-02 05:10:28Z INFO MessageListener] Received job status event. JobState: Busy
[2024-09-02 05:10:28Z INFO MessageListener] _getMessagesTokenSource is already disposed.
[2024-09-02 05:10:28Z INFO Terminal] WRITE LINE: 2024-09-02 05:10:28Z: Running job: Test workflow
[2024-09-02 05:10:28Z INFO JobDispatcher] Start renew job request 581691 for job jon_id.
[2024-09-02 05:10:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:20:28
[2024-09-02 05:10:28Z INFO HostContext] Well known directory 'Bin': '/opt/gha/bin'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper] Starting process:
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   File name: '/opt/gha/bin/Runner.Worker'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Arguments: 'spawnclient 111 114'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Working directory: '/opt/gha/bin'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'True'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Persist current code page: 'False'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper]   High priority process: 'True'
[2024-09-02 05:10:28Z INFO ProcessInvokerWrapper] Process started with process id 41891, waiting for process exit.
[2024-09-02 05:10:28Z INFO JobDispatcher] Send job request message to worker for job jon_id.
[2024-09-02 05:10:28Z INFO ProcessChannel] Sending message of length 36604, with hash '49b33ef190a0318b9cffe0580968c6b769218950451302f086c26e5b50f93dea'
[2024-09-02 05:10:28Z INFO JobNotification] Entering JobStarted Notification
[2024-09-02 05:10:28Z INFO JobNotification] Entering StartMonitor
[2024-09-02 05:11:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:21:28
[2024-09-02 05:12:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:22:28
[2024-09-02 05:13:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:23:28
[2024-09-02 05:14:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:24:28
[2024-09-02 05:15:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:25:28
[2024-09-02 05:16:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:26:28
[2024-09-02 05:17:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:27:28
[2024-09-02 05:18:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:28:28
[2024-09-02 05:19:28Z INFO JobDispatcher] Successfully renew job request 581691, job is valid till 09/02/2024 05:29:28
[2024-09-02 05:19:40Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2024-09-02 05:19:40Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2024-09-02 05:19:40Z INFO ProcessInvokerWrapper] Finished process 41891 with exit code 100, and elapsed time 00:09:11.9811022.
[2024-09-02 05:19:40Z INFO JobDispatcher] Worker finished for job jon_id. Code: 100
[2024-09-02 05:19:40Z INFO JobDispatcher] finish job request for job jon_id with result: Succeeded
[2024-09-02 05:19:40Z INFO Terminal] WRITE LINE: 2024-09-02 05:19:40Z: Job Deploy FE Dev completed with result: Succeeded
[2024-09-02 05:19:40Z INFO JobDispatcher] Stop renew job request for job jon_id.
[2024-09-02 05:19:40Z INFO JobDispatcher] job renew has been cancelled, stop renew job request 581691.
[2024-09-02 05:19:40Z INFO JobNotification] Entering JobCompleted Notification
[2024-09-02 05:19:40Z INFO JobNotification] Entering EndMonitor
[2024-09-02 05:19:40Z INFO MessageListener] Received job status event. JobState: Online
[2024-09-02 05:19:40Z WARN GitHubActionsService] GET request to url has been cancelled.
[2024-09-02 05:19:40Z INFO MessageListener] Get messages has been cancelled using local token source. Continue to get messages with new status.
[2024-09-02 05:40:34Z INFO MessageListener] No message retrieved from session 'session_id' within last 30 minutes.
[2024-09-02 05:40:34Z INFO RSAFileKeyManager] Loading RSA key parameters from file /opt/gha/.credentials_rsaparams
[2024-09-02 05:40:34Z INFO GitHubActionsService] AAD Correlation ID for this token request: Unknown
[2024-09-02 06:10:37Z INFO MessageListener] No message retrieved from session 'session_id' within last 30 minutes.
@likhith-reddy-glean likhith-reddy-glean added the bug Something isn't working label Sep 2, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug Something isn't working
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@likhith-reddy-glean