[18:26:05.411] New invocation is queued and will start shortly
[18:26:06.621] Starting the invocation (attempt 1)
[18:26:06.682] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20738cab986a5c9437596f095182e7387668425a"
[18:26:06.682] Popped gitiles commit info from properties and tags
[18:26:06.682] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:26:06.682] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:26:06.683] Buildbucket request:
{
"requestId": "8995451077197620128",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20738cab986a5c9437596f095182e7387668425a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8995451077197620128"
},
{
"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"
}
}
[18:26:07.362] Scheduled build:
{
"id": "8830021015137990881",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 746,
"createdBy": "project:chromium",
"createTime": "2021-11-20T18:26:06.743935202Z",
"updateTime": "2021-11-20T18:26:06.743935202Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20738cab986a5c9437596f095182e7387668425a",
"ref": "refs/heads/main"
}
}
}
[18:26:07.362] Task URL: https://cr-buildbucket.appspot.com/build/8830021015137990881
[18:26:07.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:2:0) after 9m10s
[18:35:17.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:2:0)
[18:35:17.725] Build status: SCHEDULED
[18:35:17.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:3:0) after 3m38s
[18:38:55.787] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:3:0)
[18:38:55.815] Build status: SCHEDULED
[18:38:55.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:4:0) after 7m30s
[18:46:25.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:4:0)
[18:46:25.916] Build status: SCHEDULED
[18:46:25.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:5:0) after 6m57s
[18:53:23.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:5:0)
[18:53:23.085] Build status: SCHEDULED
[18:53:23.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:6:0) after 2m26s
[18:55:49.277] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:6:0)
[18:55:49.304] Build status: SCHEDULED
[18:55:49.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:7:0) after 1m21s
[18:57:10.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:7:0)
[18:57:10.466] Build status: SCHEDULED
[18:57:10.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:8:0) after 4m50s
[19:02:00.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:8:0)
[19:02:00.540] Build status: SCHEDULED
[19:02:00.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:9:0) after 1m28s
[19:03:28.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:9:0)
[19:03:28.613] Build status: SCHEDULED
[19:03:28.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:10:0) after 2m54s
[19:06:22.661] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:10:0)
[19:06:22.700] Build status: SCHEDULED
[19:06:22.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:11:0) after 7m18s
[19:13:40.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:11:0)
[19:13:40.908] Build status: SCHEDULED
[19:13:40.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:12:0) after 8m40s
[19:19:47.839] Received PubSub notification, asking Buildbucket for the build status
[19:19:47.874] Build status: STARTED
[19:22:20.930] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:12:0)
[19:22:20.963] Build status: STARTED
[19:22:20.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:14:0) after 2m1s
[19:24:22.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:14:0)
[19:24:22.196] Build status: STARTED
[19:24:22.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:15:0) after 7m1s
[19:31:23.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:15:0)
[19:31:23.293] Build status: STARTED
[19:31:23.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:16:0) after 2m47s
[19:34:11.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:16:0)
[19:34:11.890] Build status: STARTED
[19:34:11.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:17:0) after 2m22s
[19:36:33.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:17:0)
[19:36:33.981] Build status: STARTED
[19:36:33.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:18:0) after 7m1s
[19:43:35.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:18:0)
[19:43:35.115] Build status: STARTED
[19:43:35.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:19:0) after 7m9s
[19:50:44.896] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:19:0)
[19:50:44.935] Build status: STARTED
[19:50:44.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:20:0) after 6m30s
[19:57:15.187] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:20:0)
[19:57:15.223] Build status: STARTED
[19:57:15.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:21:0) after 1m34s
[19:58:49.525] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:21:0)
[19:58:49.552] Build status: STARTED
[19:58:49.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:22:0) after 5m25s
[20:04:15.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:22:0)
[20:04:15.645] Build status: STARTED
[20:04:15.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:23:0) after 1m21s
[20:05:36.665] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:23:0)
[20:05:36.702] Build status: STARTED
[20:05:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:24:0) after 1m55s
[20:07:32.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:24:0)
[20:07:32.048] Build status: STARTED
[20:07:32.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:25:0) after 2m11s
[20:09:43.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:25:0)
[20:09:43.235] Build status: STARTED
[20:09:43.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:26:0) after 9m50s
[20:19:33.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:26:0)
[20:19:33.715] Build status: STARTED
[20:19:33.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:27:0) after 4m10s
[20:23:44.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:27:0)
[20:23:44.162] Build status: STARTED
[20:23:44.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:28:0) after 6m49s
[20:30:33.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:28:0)
[20:30:33.972] Build status: STARTED
[20:30:33.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:29:0) after 9m54s
[20:40:28.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:29:0)
[20:40:28.105] Build status: STARTED
[20:40:28.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:30:0) after 5m38s
[20:46:06.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:30:0)
[20:46:06.230] Build status: STARTED
[20:46:06.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:31:0) after 7m32s
[20:53:38.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:31:0)
[20:53:38.282] Build status: STARTED
[20:53:38.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:32:0) after 5m11s
[20:58:49.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:32:0)
[20:58:49.395] Build status: STARTED
[20:58:49.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:33:0) after 5m48s
[21:04:37.414] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:33:0)
[21:04:37.452] Build status: STARTED
[21:04:37.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:34:0) after 1m46s
[21:06:23.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:34:0)
[21:06:23.615] Build status: STARTED
[21:06:23.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:35:0) after 7m42s
[21:14:05.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:35:0)
[21:14:05.780] Build status: STARTED
[21:14:05.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:36:0) after 8m19s
[21:22:24.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:36:0)
[21:22:24.826] Build status: STARTED
[21:22:24.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:37:0) after 7m27s
[21:29:51.882] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:37:0)
[21:29:51.912] Build status: STARTED
[21:29:51.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:38:0) after 8m30s
[21:38:21.948] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:38:0)
[21:38:21.983] Build status: STARTED
[21:38:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:39:0) after 4m12s
[21:42:34.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:39:0)
[21:42:34.120] Build status: STARTED
[21:42:34.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:40:0) after 8m43s
[21:51:17.292] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:40:0)
[21:51:17.325] Build status: STARTED
[21:51:17.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:41:0) after 7m58s
[21:59:15.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:41:0)
[21:59:15.483] Build status: STARTED
[21:59:15.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:42:0) after 1m53s
[22:01:08.573] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:42:0)
[22:01:08.630] Build status: STARTED
[22:01:08.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:43:0) after 7m21s
[22:08:29.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:43:0)
[22:08:29.694] Build status: STARTED
[22:08:29.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:44:0) after 8m48s
[22:17:18.577] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:44:0)
[22:17:18.676] Build status: STARTED
[22:17:18.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:45:0) after 9m4s
[22:26:23.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:45:0)
[22:26:23.541] Build status: STARTED
[22:26:23.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:46:0) after 8m0s
[22:34:23.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:46:0)
[22:34:23.875] Build status: STARTED
[22:34:23.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:47:0) after 5m38s
[22:40:01.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:47:0)
[22:40:01.940] Build status: STARTED
[22:40:01.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:48:0) after 6m36s
[22:46:38.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:48:0)
[22:46:38.111] Build status: STARTED
[22:46:38.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:49:0) after 5m43s
[22:52:21.102] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:49:0)
[22:52:21.158] Build status: STARTED
[22:52:21.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:50:0) after 4m29s
[22:56:50.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:50:0)
[22:56:50.291] Build status: STARTED
[22:56:50.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:51:0) after 1m4s
[22:57:54.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:51:0)
[22:57:54.352] Build status: STARTED
[22:57:54.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:52:0) after 4m35s
[23:02:29.467] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:52:0)
[23:02:29.499] Build status: STARTED
[23:02:29.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:53:0) after 1m45s
[23:04:14.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:53:0)
[23:04:14.695] Build status: STARTED
[23:04:14.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:54:0) after 5m50s
[23:10:04.753] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:54:0)
[23:10:04.793] Build status: STARTED
[23:10:04.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:55:0) after 1m32s
[23:11:37.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:55:0)
[23:11:37.111] Build status: STARTED
[23:11:37.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:56:0) after 5m55s
[23:17:32.131] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:56:0)
[23:17:32.178] Build status: STARTED
[23:17:32.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:57:0) after 4m35s
[23:22:07.200] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:57:0)
[23:22:07.224] Build status: STARTED
[23:22:07.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:58:0) after 1m42s
[23:23:49.268] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:58:0)
[23:23:49.333] Build status: STARTED
[23:23:49.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:59:0) after 8m12s
[23:32:01.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:59:0)
[23:32:01.895] Build status: STARTED
[23:32:01.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:60:0) after 6m8s
[23:38:10.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:60:0)
[23:38:10.543] Build status: STARTED
[23:38:10.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:61:0) after 8m5s
[23:46:15.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:61:0)
[23:46:15.694] Build status: STARTED
[23:46:15.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:62:0) after 9m30s
[23:55:45.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:62:0)
[23:55:45.844] Build status: STARTED
[23:55:45.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:63:0) after 4m12s
[23:59:57.876] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:63:0)
[23:59:57.915] Build status: STARTED
[23:59:57.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:64:0) after 6m12s
[00:06:09.942] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:64:0)
[00:06:09.976] Build status: STARTED
[00:06:09.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:65:0) after 8m47s
[00:14:57.057] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:65:0)
[00:14:57.095] Build status: STARTED
[00:14:57.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:66:0) after 3m58s
[00:18:55.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:66:0)
[00:18:55.162] Build status: STARTED
[00:18:55.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:67:0) after 2m35s
[00:21:30.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:67:0)
[00:21:30.280] Build status: STARTED
[00:21:30.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:68:0) after 6m44s
[00:28:14.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:68:0)
[00:28:14.338] Build status: STARTED
[00:28:14.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:69:0) after 6m25s
[00:34:39.466] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:69:0)
[00:34:39.506] Build status: STARTED
[00:34:39.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:70:0) after 8m46s
[00:43:25.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:70:0)
[00:43:25.576] Build status: STARTED
[00:43:25.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:71:0) after 6m46s
[00:50:11.633] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:71:0)
[00:50:11.716] Build status: STARTED
[00:50:11.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:72:0) after 1m51s
[00:52:03.212] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:72:0)
[00:52:03.359] Build status: STARTED
[00:52:03.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:73:0) after 8m54s
[01:00:57.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:73:0)
[01:00:57.488] Build status: STARTED
[01:00:57.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:74:0) after 2m33s
[01:03:30.545] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:74:0)
[01:03:30.629] Build status: STARTED
[01:03:30.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:75:0) after 7m50s
[01:11:20.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:75:0)
[01:11:20.678] Build status: STARTED
[01:11:20.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:76:0) after 8m29s
[01:19:50.465] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:76:0)
[01:19:50.494] Build status: STARTED
[01:19:50.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:77:0) after 6m39s
[01:26:29.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:77:0)
[01:26:29.626] Build status: STARTED
[01:26:29.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:78:0) after 1m41s
[01:28:10.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:78:0)
[01:28:10.739] Build status: STARTED
[01:28:10.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:79:0) after 5m7s
[01:33:17.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:79:0)
[01:33:17.921] Build status: STARTED
[01:33:17.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:80:0) after 7m42s
[01:41:00.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:80:0)
[01:41:00.193] Build status: STARTED
[01:41:00.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:81:0) after 5m57s
[01:46:57.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:81:0)
[01:46:57.292] Build status: STARTED
[01:46:57.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:82:0) after 7m51s
[01:54:48.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:82:0)
[01:54:48.585] Build status: STARTED
[01:54:48.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:83:0) after 5m35s
[02:00:23.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:83:0)
[02:00:23.635] Build status: STARTED
[02:00:23.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:84:0) after 7m18s
[02:07:41.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:84:0)
[02:07:41.717] Build status: STARTED
[02:07:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:85:0) after 8m50s
[02:16:31.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:85:0)
[02:16:31.766] Build status: STARTED
[02:16:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:86:0) after 7m8s
[02:23:39.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:86:0)
[02:23:39.922] Build status: STARTED
[02:23:39.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:87:0) after 6m28s
[02:30:08.104] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:87:0)
[02:30:08.136] Build status: STARTED
[02:30:08.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:88:0) after 6m43s
[02:36:51.158] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:88:0)
[02:36:51.191] Build status: STARTED
[02:36:51.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:89:0) after 3m22s
[02:40:13.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:89:0)
[02:40:13.252] Build status: STARTED
[02:40:13.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:90:0) after 1m9s
[02:41:22.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:90:0)
[02:41:22.308] Build status: STARTED
[02:41:22.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:91:0) after 9m49s
[02:51:11.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:91:0)
[02:51:11.377] Build status: STARTED
[02:51:11.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:92:0) after 7m42s
[02:58:53.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:92:0)
[02:58:53.848] Build status: STARTED
[02:58:53.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:93:0) after 3m44s
[03:02:38.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:93:0)
[03:02:38.091] Build status: STARTED
[03:02:38.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:94:0) after 3m15s
[03:05:53.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:94:0)
[03:05:53.183] Build status: STARTED
[03:05:53.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:95:0) after 7m39s
[03:13:32.315] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:95:0)
[03:13:32.348] Build status: STARTED
[03:13:32.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:96:0) after 8m15s
[03:21:47.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:96:0)
[03:21:47.442] Build status: STARTED
[03:21:47.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:97:0) after 2m40s
[03:24:27.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:97:0)
[03:24:27.510] Build status: STARTED
[03:24:27.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:98:0) after 1m9s
[03:25:36.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:98:0)
[03:25:36.674] Build status: STARTED
[03:25:36.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:99:0) after 6m24s
[03:32:00.735] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:99:0)
[03:32:00.765] Build status: STARTED
[03:32:00.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:100:0) after 5m1s
[03:37:01.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:100:0)
[03:37:01.838] Build status: STARTED
[03:37:01.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:101:0) after 2m22s
[03:39:23.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:101:0)
[03:39:23.906] Build status: STARTED
[03:39:23.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:102:0) after 7m24s
[03:46:48.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:102:0)
[03:46:48.334] Build status: STARTED
[03:46:48.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:103:0) after 4m13s
[03:51:01.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:103:0)
[03:51:01.974] Build status: STARTED
[03:51:01.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8995451077197620128:104:0) after 7m17s
[03:54:51.048] Received PubSub notification, asking Buildbucket for the build status
[03:54:51.078] Build:
{
"id": "8830021015137990881",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 746,
"createdBy": "project:chromium",
"createTime": "2021-11-20T18:26:06.743935202Z",
"startTime": "2021-11-20T19:19:47.273235Z",
"endTime": "2021-11-21T03:54:50.492156308Z",
"updateTime": "2021-11-21T03:54:50.492156308Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "20738cab986a5c9437596f095182e7387668425a",
"ref": "refs/heads/main"
}
}
}
[03:54:51.078] Invocation finished in 9h28m45.683203232s with status SUCCEEDED