[20:16:39.309] New invocation is queued and will start shortly
[20:16:42.223] Starting the invocation (attempt 1)
[20:16:42.255] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49bbfe59f4dd5390ffcb49e3d5106c238b1b0afd"
[20:16:42.255] Popped gitiles commit info from properties and tags
[20:16:42.255] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:16:42.255] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:16:42.255] Buildbucket request:
{
"requestId": "8940361165515579456",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49bbfe59f4dd5390ffcb49e3d5106c238b1b0afd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8940361165515579456"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:16:42.969] Scheduled build:
{
"id": "8774931101648244913",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 4353,
"createdBy": "project:chromium",
"createTime": "2023-07-21T20:16:42.331483661Z",
"updateTime": "2023-07-21T20:16:42.331483661Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49bbfe59f4dd5390ffcb49e3d5106c238b1b0afd",
"ref": "refs/heads/main"
}
}
}
[20:16:42.969] Task URL: https://cr-buildbucket.appspot.com/build/8774931101648244913
[20:16:42.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:2:0) after 5m25s
[20:16:44.175] Received PubSub notification, asking Buildbucket for the build status
[20:16:44.255] Build status: SCHEDULED
[20:22:07.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:2:0)
[20:22:08.018] Build status: SCHEDULED
[20:22:08.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:4:0) after 3m34s
[20:25:09.896] Received PubSub notification, asking Buildbucket for the build status
[20:25:09.916] Build status: STARTED
[20:25:42.081] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:4:0)
[20:25:42.107] Build status: STARTED
[20:25:42.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:6:0) after 3m53s
[20:29:35.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:6:0)
[20:29:35.282] Build status: STARTED
[20:29:35.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:7:0) after 1m19s
[20:30:54.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:7:0)
[20:30:54.339] Build status: STARTED
[20:30:54.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:8:0) after 1m24s
[20:32:18.372] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:8:0)
[20:32:18.401] Build status: STARTED
[20:32:18.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:9:0) after 2m57s
[20:35:15.470] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:9:0)
[20:35:15.554] Build status: STARTED
[20:35:15.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:10:0) after 1m35s
[20:36:50.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:10:0)
[20:36:50.624] Build status: STARTED
[20:36:50.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:11:0) after 8m2s
[20:44:52.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:11:0)
[20:44:52.820] Build status: STARTED
[20:44:52.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:12:0) after 7m40s
[20:52:32.989] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:12:0)
[20:52:33.046] Build status: STARTED
[20:52:33.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:13:0) after 6m39s
[20:59:12.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:13:0)
[20:59:12.117] Build status: STARTED
[20:59:12.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:14:0) after 3m2s
[21:02:14.411] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:14:0)
[21:02:14.438] Build status: STARTED
[21:02:14.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:15:0) after 5m4s
[21:07:18.473] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:15:0)
[21:07:18.535] Build status: STARTED
[21:07:18.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:16:0) after 4m44s
[21:12:02.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:16:0)
[21:12:02.587] Build status: STARTED
[21:12:02.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:17:0) after 6m18s
[21:18:20.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:17:0)
[21:18:20.715] Build status: STARTED
[21:18:20.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:18:0) after 2m8s
[21:20:28.747] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:18:0)
[21:20:28.763] Build status: STARTED
[21:20:28.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:19:0) after 8m28s
[21:28:56.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:19:0)
[21:28:56.802] Build status: STARTED
[21:28:56.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:20:0) after 2m20s
[21:31:16.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:20:0)
[21:31:16.843] Build status: STARTED
[21:31:16.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:21:0) after 3m29s
[21:34:46.113] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:21:0)
[21:34:46.147] Build status: STARTED
[21:34:46.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:22:0) after 4m5s
[21:38:51.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:22:0)
[21:38:51.215] Build status: STARTED
[21:38:51.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:23:0) after 3m29s
[21:42:20.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:23:0)
[21:42:20.376] Build status: STARTED
[21:42:20.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:24:0) after 8m55s
[21:51:15.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:24:0)
[21:51:15.512] Build status: STARTED
[21:51:15.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:25:0) after 3m29s
[21:54:44.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:25:0)
[21:54:44.636] Build status: STARTED
[21:54:44.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:26:0) after 8m29s
[22:03:14.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:26:0)
[22:03:14.634] Build status: STARTED
[22:03:14.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:27:0) after 4m24s
[22:07:38.665] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:27:0)
[22:07:38.691] Build status: STARTED
[22:07:38.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:28:0) after 1m6s
[22:08:44.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:28:0)
[22:08:44.935] Build status: STARTED
[22:08:44.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:29:0) after 4m58s
[22:13:43.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:29:0)
[22:13:43.624] Build status: STARTED
[22:13:43.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:30:0) after 2m53s
[22:16:36.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:30:0)
[22:16:36.839] Build status: STARTED
[22:16:36.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:31:0) after 6m8s
[22:22:44.969] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:31:0)
[22:22:44.987] Build status: STARTED
[22:22:44.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:32:0) after 5m6s
[22:27:50.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:32:0)
[22:27:51.013] Build status: STARTED
[22:27:51.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:33:0) after 4m50s
[22:32:41.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:33:0)
[22:32:41.128] Build status: STARTED
[22:32:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:34:0) after 8m26s
[22:41:07.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:34:0)
[22:41:07.255] Build status: STARTED
[22:41:07.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:35:0) after 2m7s
[22:43:14.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:35:0)
[22:43:14.330] Build status: STARTED
[22:43:14.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:36:0) after 5m45s
[22:48:59.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:36:0)
[22:48:59.552] Build status: STARTED
[22:48:59.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:37:0) after 8m2s
[22:57:01.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:37:0)
[22:57:01.607] Build status: STARTED
[22:57:01.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:38:0) after 4m31s
[23:01:32.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:38:0)
[23:01:32.778] Build status: STARTED
[23:01:32.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:39:0) after 9m17s
[23:10:49.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:39:0)
[23:10:49.823] Build status: STARTED
[23:10:49.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:40:0) after 7m52s
[23:18:41.970] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:40:0)
[23:18:41.987] Build status: STARTED
[23:18:41.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:41:0) after 7m46s
[23:26:28.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:41:0)
[23:26:28.135] Build status: STARTED
[23:26:28.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:42:0) after 9m7s
[23:35:35.322] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:42:0)
[23:35:35.340] Build status: STARTED
[23:35:35.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:43:0) after 5m51s
[23:41:26.474] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:43:0)
[23:41:26.493] Build status: STARTED
[23:41:26.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:44:0) after 7m36s
[23:49:02.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:44:0)
[23:49:02.553] Build status: STARTED
[23:49:02.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:45:0) after 1m25s
[23:50:27.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:45:0)
[23:50:27.622] Build status: STARTED
[23:50:27.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:46:0) after 5m17s
[23:55:44.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:46:0)
[23:55:44.827] Build status: STARTED
[23:55:44.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:47:0) after 1m57s
[23:57:41.874] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:47:0)
[23:57:41.894] Build status: STARTED
[23:57:41.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:48:0) after 2m54s
[00:00:35.984] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:48:0)
[00:00:36.115] Build status: STARTED
[00:00:36.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:49:0) after 9m26s
[00:10:02.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:49:0)
[00:10:02.476] Build status: STARTED
[00:10:02.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:50:0) after 1m40s
[00:11:43.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:50:0)
[00:11:43.071] Build status: STARTED
[00:11:43.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:51:0) after 9m11s
[00:20:54.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:51:0)
[00:20:54.243] Build status: STARTED
[00:20:54.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:52:0) after 6m29s
[00:27:23.529] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:52:0)
[00:27:23.551] Build status: STARTED
[00:27:23.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:53:0) after 2m55s
[00:30:18.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:53:0)
[00:30:18.929] Build status: STARTED
[00:30:18.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:54:0) after 7m10s
[00:37:29.084] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:54:0)
[00:37:29.165] Build status: STARTED
[00:37:29.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:55:0) after 9m37s
[00:47:06.262] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:55:0)
[00:47:06.282] Build status: STARTED
[00:47:06.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:56:0) after 5m22s
[00:52:28.714] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:56:0)
[00:52:28.732] Build status: STARTED
[00:52:28.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:57:0) after 5m54s
[00:58:22.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:57:0)
[00:58:22.783] Build status: STARTED
[00:58:22.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:58:0) after 4m40s
[01:03:02.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:58:0)
[01:03:02.823] Build status: STARTED
[01:03:02.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:59:0) after 9m37s
[01:12:40.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:59:0)
[01:12:40.247] Build status: STARTED
[01:12:40.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:60:0) after 5m33s
[01:18:13.342] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:60:0)
[01:18:13.362] Build status: STARTED
[01:18:13.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:61:0) after 8m51s
[01:27:04.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:61:0)
[01:27:04.418] Build status: STARTED
[01:27:04.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:62:0) after 4m1s
[01:31:05.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:62:0)
[01:31:05.428] Build status: STARTED
[01:31:05.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:63:0) after 4m28s
[01:35:33.737] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:63:0)
[01:35:33.761] Build status: STARTED
[01:35:33.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:64:0) after 7m37s
[01:43:10.796] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:64:0)
[01:43:10.813] Build status: STARTED
[01:43:10.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:65:0) after 8m41s
[01:51:51.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:65:0)
[01:51:51.948] Build status: STARTED
[01:51:51.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:66:0) after 2m31s
[01:54:22.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:66:0)
[01:54:22.998] Build status: STARTED
[01:54:22.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:67:0) after 2m17s
[01:56:40.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:67:0)
[01:56:40.058] Build status: STARTED
[01:56:40.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:68:0) after 3m20s
[02:00:00.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:68:0)
[02:00:00.120] Build status: STARTED
[02:00:00.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:69:0) after 4m50s
[02:04:50.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:69:0)
[02:04:50.165] Build status: STARTED
[02:04:50.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:70:0) after 2m6s
[02:06:56.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:70:0)
[02:06:56.248] Build status: STARTED
[02:06:56.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:71:0) after 4m28s
[02:11:24.277] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:71:0)
[02:11:24.298] Build status: STARTED
[02:11:24.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:72:0) after 1m55s
[02:13:19.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:72:0)
[02:13:19.694] Build status: STARTED
[02:13:19.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:73:0) after 8m14s
[02:21:33.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:73:0)
[02:21:33.771] Build status: STARTED
[02:21:33.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:74:0) after 5m14s
[02:26:47.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:74:0)
[02:26:47.790] Build status: STARTED
[02:26:47.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:75:0) after 6m4s
[02:32:51.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:75:0)
[02:32:51.870] Build status: STARTED
[02:32:51.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:76:0) after 8m8s
[02:41:00.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:76:0)
[02:41:00.189] Build status: STARTED
[02:41:00.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:77:0) after 1m38s
[02:42:38.197] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:77:0)
[02:42:38.218] Build status: STARTED
[02:42:38.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:78:0) after 6m7s
[02:48:45.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:78:0)
[02:48:45.268] Build status: STARTED
[02:48:45.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:79:0) after 4m5s
[02:52:50.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:79:0)
[02:52:50.317] Build status: STARTED
[02:52:50.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:80:0) after 3m17s
[02:56:07.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:80:0)
[02:56:07.679] Build status: STARTED
[02:56:07.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:81:0) after 4m44s
[03:00:51.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:81:0)
[03:00:51.759] Build status: STARTED
[03:00:51.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:82:0) after 7m44s
[03:08:35.884] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:82:0)
[03:08:35.904] Build status: STARTED
[03:08:35.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:83:0) after 5m22s
[03:13:57.977] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:83:0)
[03:13:57.993] Build status: STARTED
[03:13:57.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:84:0) after 9m36s
[03:23:34.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:84:0)
[03:23:34.069] Build status: STARTED
[03:23:34.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:85:0) after 3m25s
[03:26:59.248] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:85:0)
[03:26:59.264] Build status: STARTED
[03:26:59.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:86:0) after 1m44s
[03:28:43.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:86:0)
[03:28:43.440] Build status: STARTED
[03:28:43.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:87:0) after 6m31s
[03:35:14.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:87:0)
[03:35:14.653] Build status: STARTED
[03:35:14.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:88:0) after 7m27s
[03:42:41.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:88:0)
[03:42:41.758] Build status: STARTED
[03:42:41.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:89:0) after 2m11s
[03:44:52.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:89:0)
[03:44:52.811] Build status: STARTED
[03:44:52.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:90:0) after 4m57s
[03:49:49.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:90:0)
[03:49:49.979] Build status: STARTED
[03:49:49.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:91:0) after 4m52s
[03:54:42.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:91:0)
[03:54:42.229] Build status: STARTED
[03:54:42.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:92:0) after 6m56s
[04:01:38.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:92:0)
[04:01:38.284] Build status: STARTED
[04:01:38.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:93:0) after 9m10s
[04:10:48.359] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:93:0)
[04:10:48.377] Build status: STARTED
[04:10:48.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:94:0) after 8m13s
[04:19:01.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:94:0)
[04:19:01.423] Build status: STARTED
[04:19:01.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:95:0) after 8m30s
[04:27:31.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:95:0)
[04:27:31.540] Build status: STARTED
[04:27:31.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:96:0) after 9m15s
[04:36:46.578] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:96:0)
[04:36:46.596] Build status: STARTED
[04:36:46.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:97:0) after 6m48s
[04:43:34.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:97:0)
[04:43:34.794] Build status: STARTED
[04:43:34.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:98:0) after 4m1s
[04:47:35.833] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:98:0)
[04:47:35.848] Build status: STARTED
[04:47:35.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:99:0) after 7m36s
[04:55:11.894] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:99:0)
[04:55:11.916] Build status: STARTED
[04:55:11.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:100:0) after 8m4s
[05:03:15.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:100:0)
[05:03:16.094] Build status: STARTED
[05:03:16.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:101:0) after 1m54s
[05:05:10.127] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:101:0)
[05:05:10.144] Build status: STARTED
[05:05:10.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:102:0) after 6m37s
[05:11:47.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:102:0)
[05:11:47.307] Build status: STARTED
[05:11:47.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:103:0) after 4m49s
[05:16:36.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:103:0)
[05:16:36.579] Build status: STARTED
[05:16:36.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:104:0) after 4m58s
[05:21:34.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:104:0)
[05:21:34.636] Build status: STARTED
[05:21:34.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:105:0) after 5m2s
[05:26:36.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:105:0)
[05:26:36.741] Build status: STARTED
[05:26:36.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:106:0) after 8m46s
[05:35:22.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:106:0)
[05:35:22.795] Build status: STARTED
[05:35:22.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:107:0) after 7m21s
[05:42:43.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:107:0)
[05:42:43.843] Build status: STARTED
[05:42:43.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:108:0) after 5m51s
[05:48:35.074] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:108:0)
[05:48:35.091] Build status: STARTED
[05:48:35.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:109:0) after 5m48s
[05:54:23.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:109:0)
[05:54:23.216] Build status: STARTED
[05:54:23.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:110:0) after 6m7s
[06:00:30.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:110:0)
[06:00:30.278] Build status: STARTED
[06:00:30.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:111:0) after 1m37s
[06:02:07.337] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:111:0)
[06:02:07.369] Build status: STARTED
[06:02:07.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:112:0) after 3m52s
[06:05:59.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:112:0)
[06:05:59.435] Build status: STARTED
[06:05:59.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:113:0) after 4m34s
[06:10:33.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:113:0)
[06:10:33.514] Build status: STARTED
[06:10:33.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:114:0) after 5m21s
[06:15:54.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:114:0)
[06:15:54.562] Build status: STARTED
[06:15:54.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:115:0) after 3m26s
[06:19:20.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:115:0)
[06:19:20.600] Build status: STARTED
[06:19:20.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:116:0) after 6m36s
[06:25:56.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:116:0)
[06:25:56.714] Build status: STARTED
[06:25:56.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:117:0) after 5m3s
[06:30:59.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:117:0)
[06:30:59.762] Build status: STARTED
[06:30:59.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:118:0) after 1m8s
[06:32:07.842] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:118:0)
[06:32:07.869] Build status: STARTED
[06:32:07.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:119:0) after 7m42s
[06:39:49.897] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:119:0)
[06:39:49.920] Build status: STARTED
[06:39:49.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:120:0) after 7m8s
[06:46:58.010] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:120:0)
[06:46:58.029] Build status: STARTED
[06:46:58.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:121:0) after 9m45s
[06:56:43.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:121:0)
[06:56:43.139] Build status: STARTED
[06:56:43.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:122:0) after 1m59s
[06:58:42.328] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:122:0)
[06:58:42.403] Build status: STARTED
[06:58:42.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:123:0) after 3m0s
[07:01:42.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:123:0)
[07:01:42.499] Build status: STARTED
[07:01:42.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:124:0) after 5m42s
[07:07:24.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:124:0)
[07:07:24.761] Build status: STARTED
[07:07:24.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:125:0) after 9m16s
[07:16:40.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:125:0)
[07:16:40.816] Build status: STARTED
[07:16:40.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:126:0) after 9m0s
[07:25:40.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:126:0)
[07:25:40.914] Build status: STARTED
[07:25:40.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:127:0) after 8m39s
[07:34:20.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:127:0)
[07:34:20.053] Build status: STARTED
[07:34:20.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:128:0) after 5m59s
[07:40:19.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:128:0)
[07:40:19.157] Build status: STARTED
[07:40:19.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:129:0) after 3m55s
[07:44:14.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:129:0)
[07:44:14.405] Build status: STARTED
[07:44:14.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:130:0) after 2m54s
[07:47:08.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:130:0)
[07:47:08.642] Build status: STARTED
[07:47:08.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:131:0) after 5m11s
[07:52:19.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:131:0)
[07:52:19.731] Build status: STARTED
[07:52:19.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:132:0) after 4m47s
[07:57:06.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:132:0)
[07:57:06.854] Build status: STARTED
[07:57:06.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:133:0) after 1m24s
[07:58:31.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:133:0)
[07:58:31.123] Build status: STARTED
[07:58:31.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:134:0) after 6m55s
[08:05:26.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:134:0)
[08:05:26.249] Build status: STARTED
[08:05:26.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8940361165515579456:135:0) after 7m50s
[08:08:59.511] Received PubSub notification, asking Buildbucket for the build status
[08:08:59.534] Build:
{
"id": "8774931101648244913",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 4353,
"createdBy": "project:chromium",
"createTime": "2023-07-21T20:16:42.331483661Z",
"startTime": "2023-07-21T20:25:08.957593Z",
"endTime": "2023-07-22T08:08:58.939599407Z",
"updateTime": "2023-07-22T08:08:58.939599407Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49bbfe59f4dd5390ffcb49e3d5106c238b1b0afd",
"ref": "refs/heads/main"
}
}
}
[08:08:59.534] Invocation finished in 11h52m20.2745141s with status SUCCEEDED