[17:10:09.386] New invocation is queued and will start shortly
[17:10:11.505] Starting the invocation (attempt 1)
[17:10:11.553] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94b15cc9f494a2bc8d2d9b7032443aed084bb5cd"
[17:10:11.553] Popped gitiles commit info from properties and tags
[17:10:11.553] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:10:11.553] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:10:11.553] Buildbucket request:
{
"requestId": "8994278093972804640",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94b15cc9f494a2bc8d2d9b7032443aed084bb5cd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8994278093972804640"
},
{
"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"
}
}
[17:10:13.464] Scheduled build:
{
"id": "8828848030965705105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 800,
"createdBy": "project:chromium",
"createTime": "2021-12-03T17:10:11.622995957Z",
"updateTime": "2021-12-03T17:10:11.622995957Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94b15cc9f494a2bc8d2d9b7032443aed084bb5cd",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:10:13.464] Task URL: https://cr-buildbucket.appspot.com/build/8828848030965705105
[17:10:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:2:0) after 7m58s
[17:18:11.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:2:0)
[17:18:11.972] Build status: SCHEDULED
[17:18:11.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:3:0) after 8m8s
[17:26:19.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:3:0)
[17:26:20.031] Build status: SCHEDULED
[17:26:20.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:4:0) after 3m4s
[17:29:24.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:4:0)
[17:29:24.136] Build status: SCHEDULED
[17:29:24.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:5:0) after 2m18s
[17:31:42.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:5:0)
[17:31:42.196] Build status: SCHEDULED
[17:31:42.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:6:0) after 4m11s
[17:35:53.666] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:6:0)
[17:35:53.703] Build status: SCHEDULED
[17:35:53.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:7:0) after 9m38s
[17:45:31.731] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:7:0)
[17:45:31.766] Build status: SCHEDULED
[17:45:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:8:0) after 9m36s
[17:55:07.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:8:0)
[17:55:07.775] Build status: SCHEDULED
[17:55:07.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:9:0) after 6m51s
[18:01:58.901] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:9:0)
[18:01:58.951] Build status: SCHEDULED
[18:01:58.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:10:0) after 4m16s
[18:06:15.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:10:0)
[18:06:15.429] Build status: SCHEDULED
[18:06:15.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:11:0) after 8m55s
[18:15:10.673] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:11:0)
[18:15:10.858] Build status: SCHEDULED
[18:15:10.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:12:0) after 6m29s
[18:21:39.897] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:12:0)
[18:21:39.927] Build status: SCHEDULED
[18:21:39.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:13:0) after 3m26s
[18:25:05.948] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:13:0)
[18:25:06.004] Build status: SCHEDULED
[18:25:06.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:14:0) after 8m47s
[18:33:53.027] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:14:0)
[18:33:53.063] Build status: SCHEDULED
[18:33:53.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:15:0) after 6m21s
[18:40:14.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:15:0)
[18:40:14.148] Build status: SCHEDULED
[18:40:14.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:16:0) after 2m55s
[18:43:09.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:16:0)
[18:43:09.215] Build status: SCHEDULED
[18:43:09.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:17:0) after 8m16s
[18:51:25.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:17:0)
[18:51:25.279] Build status: SCHEDULED
[18:51:25.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:18:0) after 1m47s
[18:53:12.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:18:0)
[18:53:12.428] Build status: SCHEDULED
[18:53:12.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:19:0) after 1m40s
[18:54:52.465] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:19:0)
[18:54:52.495] Build status: SCHEDULED
[18:54:52.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:20:0) after 6m40s
[19:01:32.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:20:0)
[19:01:32.559] Build status: SCHEDULED
[19:01:32.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:21:0) after 1m53s
[19:02:57.904] Received PubSub notification, asking Buildbucket for the build status
[19:02:58.002] Build status: STARTED
[19:03:25.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:21:0)
[19:03:25.764] Build status: STARTED
[19:03:25.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:23:0) after 9m46s
[19:13:11.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:23:0)
[19:13:11.835] Build status: STARTED
[19:13:11.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:24:0) after 2m57s
[19:16:08.908] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:24:0)
[19:16:09.043] Build status: STARTED
[19:16:09.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:25:0) after 5m32s
[19:21:41.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:25:0)
[19:21:41.101] Build status: STARTED
[19:21:41.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:26:0) after 8m55s
[19:30:36.209] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:26:0)
[19:30:36.244] Build status: STARTED
[19:30:36.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:27:0) after 2m42s
[19:33:18.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:27:0)
[19:33:18.310] Build status: STARTED
[19:33:18.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:28:0) after 7m30s
[19:40:48.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:28:0)
[19:40:48.398] Build status: STARTED
[19:40:48.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:29:0) after 5m6s
[19:45:54.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:29:0)
[19:45:54.464] Build status: STARTED
[19:45:54.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:30:0) after 6m15s
[19:52:09.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:30:0)
[19:52:09.589] Build status: STARTED
[19:52:09.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:31:0) after 1m15s
[19:53:24.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:31:0)
[19:53:24.748] Build status: STARTED
[19:53:24.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:32:0) after 6m43s
[20:00:07.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:32:0)
[20:00:07.860] Build status: STARTED
[20:00:07.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:33:0) after 4m33s
[20:04:40.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:33:0)
[20:04:41.019] Build status: STARTED
[20:04:41.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:34:0) after 7m1s
[20:11:42.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:34:0)
[20:11:42.078] Build status: STARTED
[20:11:42.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:35:0) after 1m14s
[20:12:56.351] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:35:0)
[20:12:56.384] Build status: STARTED
[20:12:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:36:0) after 3m26s
[20:16:22.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:36:0)
[20:16:22.559] Build status: STARTED
[20:16:22.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:37:0) after 8m30s
[20:24:52.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:37:0)
[20:24:52.632] Build status: STARTED
[20:24:52.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:38:0) after 2m34s
[20:27:26.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:38:0)
[20:27:26.689] Build status: STARTED
[20:27:26.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:39:0) after 7m57s
[20:35:23.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:39:0)
[20:35:23.877] Build status: STARTED
[20:35:23.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:40:0) after 4m21s
[20:39:44.987] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:40:0)
[20:39:45.023] Build status: STARTED
[20:39:45.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:41:0) after 6m40s
[20:46:25.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:41:0)
[20:46:25.407] Build status: STARTED
[20:46:25.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:42:0) after 9m27s
[20:55:52.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:42:0)
[20:55:52.668] Build status: STARTED
[20:55:52.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:43:0) after 4m25s
[21:00:17.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:43:0)
[21:00:17.842] Build status: STARTED
[21:00:17.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:44:0) after 6m25s
[21:06:42.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:44:0)
[21:06:43.059] Build status: STARTED
[21:06:43.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:45:0) after 8m30s
[21:15:13.163] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:45:0)
[21:15:13.205] Build status: STARTED
[21:15:13.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:46:0) after 1m40s
[21:16:53.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:46:0)
[21:16:53.295] Build status: STARTED
[21:16:53.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:47:0) after 9m38s
[21:26:31.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:47:0)
[21:26:31.369] Build status: STARTED
[21:26:31.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:48:0) after 6m53s
[21:33:24.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:48:0)
[21:33:24.387] Build status: STARTED
[21:33:24.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:49:0) after 7m30s
[21:40:54.416] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:49:0)
[21:40:54.451] Build status: STARTED
[21:40:54.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:50:0) after 9m37s
[21:50:31.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:50:0)
[21:50:31.568] Build status: STARTED
[21:50:31.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:51:0) after 3m5s
[21:53:36.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:51:0)
[21:53:36.638] Build status: STARTED
[21:53:36.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:52:0) after 9m24s
[22:03:00.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:52:0)
[22:03:00.693] Build status: STARTED
[22:03:00.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:53:0) after 8m31s
[22:11:31.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:53:0)
[22:11:31.839] Build status: STARTED
[22:11:31.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:54:0) after 8m49s
[22:20:21.267] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:54:0)
[22:20:21.297] Build status: STARTED
[22:20:21.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:55:0) after 6m38s
[22:26:59.620] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:55:0)
[22:26:59.665] Build status: STARTED
[22:26:59.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:56:0) after 7m36s
[22:34:35.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:56:0)
[22:34:35.792] Build status: STARTED
[22:34:35.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:57:0) after 2m45s
[22:37:20.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:57:0)
[22:37:20.855] Build status: STARTED
[22:37:20.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:58:0) after 4m36s
[22:41:56.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:58:0)
[22:41:57.018] Build status: STARTED
[22:41:57.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:59:0) after 7m38s
[22:49:35.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:59:0)
[22:49:35.248] Build status: STARTED
[22:49:35.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:60:0) after 1m49s
[22:51:24.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:60:0)
[22:51:24.360] Build status: STARTED
[22:51:24.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:61:0) after 2m0s
[22:53:24.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:61:0)
[22:53:24.528] Build status: STARTED
[22:53:24.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:62:0) after 1m16s
[22:54:40.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:62:0)
[22:54:40.867] Build status: STARTED
[22:54:40.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:63:0) after 5m3s
[22:59:43.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:63:0)
[22:59:43.906] Build status: STARTED
[22:59:43.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:64:0) after 1m33s
[23:01:17.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:64:0)
[23:01:17.461] Build status: STARTED
[23:01:17.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:65:0) after 3m21s
[23:04:38.486] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:65:0)
[23:04:38.523] Build status: STARTED
[23:04:38.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:66:0) after 7m25s
[23:12:03.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:66:0)
[23:12:03.668] Build status: STARTED
[23:12:03.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:67:0) after 7m19s
[23:19:22.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:67:0)
[23:19:22.710] Build status: STARTED
[23:19:22.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:68:0) after 4m38s
[23:24:00.875] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:68:0)
[23:24:00.901] Build status: STARTED
[23:24:00.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:69:0) after 6m56s
[23:30:57.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:69:0)
[23:30:57.236] Build status: STARTED
[23:30:57.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:70:0) after 9m58s
[23:40:55.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:70:0)
[23:40:55.323] Build status: STARTED
[23:40:55.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:71:0) after 2m36s
[23:43:31.345] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:71:0)
[23:43:31.376] Build status: STARTED
[23:43:31.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:72:0) after 7m23s
[23:50:54.401] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:72:0)
[23:50:54.435] Build status: STARTED
[23:50:54.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:73:0) after 3m31s
[23:54:25.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:73:0)
[23:54:25.514] Build status: STARTED
[23:54:25.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:74:0) after 5m55s
[00:00:20.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:74:0)
[00:00:20.842] Build status: STARTED
[00:00:20.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:75:0) after 3m39s
[00:03:59.977] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:75:0)
[00:04:00.008] Build status: STARTED
[00:04:00.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:76:0) after 8m26s
[00:12:26.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:76:0)
[00:12:26.067] Build status: STARTED
[00:12:26.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:77:0) after 1m6s
[00:13:32.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:77:0)
[00:13:32.483] Build status: STARTED
[00:13:32.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:78:0) after 4m53s
[00:18:25.512] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:78:0)
[00:18:25.544] Build status: STARTED
[00:18:25.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:79:0) after 3m23s
[00:21:48.708] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:79:0)
[00:21:48.745] Build status: STARTED
[00:21:48.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:80:0) after 3m4s
[00:24:52.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:80:0)
[00:24:52.801] Build status: STARTED
[00:24:52.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:81:0) after 6m51s
[00:31:43.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:81:0)
[00:31:43.903] Build status: STARTED
[00:31:43.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:82:0) after 4m37s
[00:36:21.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:82:0)
[00:36:21.268] Build status: STARTED
[00:36:21.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:83:0) after 5m9s
[00:41:30.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:83:0)
[00:41:30.355] Build status: STARTED
[00:41:30.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:84:0) after 5m48s
[00:47:18.474] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:84:0)
[00:47:18.507] Build status: STARTED
[00:47:18.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:85:0) after 1m23s
[00:48:41.927] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:85:0)
[00:48:41.962] Build status: STARTED
[00:48:41.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:86:0) after 7m45s
[00:56:27.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:86:0)
[00:56:27.099] Build status: STARTED
[00:56:27.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:87:0) after 9m16s
[01:05:43.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:87:0)
[01:05:43.245] Build status: STARTED
[01:05:43.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:88:0) after 6m6s
[01:11:49.305] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:88:0)
[01:11:49.349] Build status: STARTED
[01:11:49.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:89:0) after 5m40s
[01:17:29.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:89:0)
[01:17:29.624] Build status: STARTED
[01:17:29.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:90:0) after 2m17s
[01:19:46.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:90:0)
[01:19:46.689] Build status: STARTED
[01:19:46.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:91:0) after 2m26s
[01:22:12.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:91:0)
[01:22:12.936] Build status: STARTED
[01:22:12.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:92:0) after 1m36s
[01:23:49.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:92:0)
[01:23:49.075] Build status: STARTED
[01:23:49.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:93:0) after 5m18s
[01:29:07.132] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:93:0)
[01:29:07.163] Build status: STARTED
[01:29:07.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:94:0) after 2m37s
[01:31:44.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:94:0)
[01:31:44.377] Build status: STARTED
[01:31:44.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:95:0) after 6m8s
[01:37:52.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:95:0)
[01:37:52.658] Build status: STARTED
[01:37:52.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:96:0) after 3m45s
[01:41:37.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:96:0)
[01:41:37.712] Build status: STARTED
[01:41:37.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:97:0) after 6m40s
[01:48:17.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:97:0)
[01:48:17.797] Build status: STARTED
[01:48:17.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:98:0) after 2m26s
[01:50:43.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:98:0)
[01:50:43.856] Build status: STARTED
[01:50:43.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:99:0) after 3m55s
[01:54:39.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:99:0)
[01:54:39.150] Build status: STARTED
[01:54:39.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:100:0) after 9m18s
[02:03:57.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:100:0)
[02:03:57.237] Build status: STARTED
[02:03:57.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:101:0) after 6m15s
[02:10:12.323] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:101:0)
[02:10:12.349] Build status: STARTED
[02:10:12.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:102:0) after 5m15s
[02:15:27.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:102:0)
[02:15:27.407] Build status: STARTED
[02:15:27.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:103:0) after 3m28s
[02:18:55.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:103:0)
[02:18:55.466] Build status: STARTED
[02:18:55.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:104:0) after 3m43s
[02:22:38.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:104:0)
[02:22:38.668] Build status: STARTED
[02:22:38.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:105:0) after 2m36s
[02:25:14.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:105:0)
[02:25:14.734] Build status: STARTED
[02:25:14.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:106:0) after 7m54s
[02:33:08.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:106:0)
[02:33:08.821] Build status: STARTED
[02:33:08.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:107:0) after 7m27s
[02:40:35.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:107:0)
[02:40:36.060] Build status: STARTED
[02:40:36.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:108:0) after 1m18s
[02:41:54.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:108:0)
[02:41:54.135] Build status: STARTED
[02:41:54.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:109:0) after 7m45s
[02:49:39.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:109:0)
[02:49:39.300] Build status: STARTED
[02:49:39.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:110:0) after 9m1s
[02:58:40.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:110:0)
[02:58:40.381] Build status: STARTED
[02:58:40.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:111:0) after 9m52s
[03:08:32.577] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:111:0)
[03:08:32.615] Build status: STARTED
[03:08:32.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8994278093972804640:112:0) after 1m25s
[03:09:13.193] Received PubSub notification, asking Buildbucket for the build status
[03:09:13.226] Build:
{
"id": "8828848030965705105",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 800,
"createdBy": "project:chromium",
"createTime": "2021-12-03T17:10:11.622995957Z",
"startTime": "2021-12-03T19:02:56.027776Z",
"endTime": "2021-12-04T03:09:12.870872082Z",
"updateTime": "2021-12-04T03:09:12.870872082Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94b15cc9f494a2bc8d2d9b7032443aed084bb5cd",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:09:13.226] Invocation finished in 9h59m3.856081228s with status SUCCEEDED