[03:40:48.916] New invocation is queued and will start shortly
[03:40:50.054] Starting the invocation (attempt 1)
[03:40:50.109] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8834821f452a3d424edd0ed2a1e9ceeda38d0ea"
[03:40:50.109] Popped gitiles commit info from properties and tags
[03:40:50.109] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:40:50.109] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:40:50.109] Buildbucket request:
{
"requestId": "8979833498692524160",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8834821f452a3d424edd0ed2a1e9ceeda38d0ea",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8979833498692524160"
},
{
"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"
}
}
[03:40:50.802] Scheduled build:
{
"id": "8814403436638069361",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 1496,
"createdBy": "project:chromium",
"createTime": "2022-05-12T03:40:50.243567797Z",
"updateTime": "2022-05-12T03:40:50.243567797Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8834821f452a3d424edd0ed2a1e9ceeda38d0ea",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:40:50.802] Task URL: https://cr-buildbucket.appspot.com/build/8814403436638069361
[03:40:50.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:2:0) after 8m48s
[03:41:52.144] Received PubSub notification, asking Buildbucket for the build status
[03:41:52.168] Build status: STARTED
[03:49:38.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:2:0)
[03:49:38.850] Build status: STARTED
[03:49:38.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:4:0) after 2m35s
[03:52:13.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:4:0)
[03:52:13.940] Build status: STARTED
[03:52:13.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:5:0) after 3m35s
[03:55:49.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:5:0)
[03:55:49.064] Build status: STARTED
[03:55:49.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:6:0) after 2m55s
[03:58:44.092] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:6:0)
[03:58:44.122] Build status: STARTED
[03:58:44.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:7:0) after 1m20s
[04:00:04.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:7:0)
[04:00:04.201] Build status: STARTED
[04:00:04.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:8:0) after 4m39s
[04:04:43.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:8:0)
[04:04:43.250] Build status: STARTED
[04:04:43.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:9:0) after 3m13s
[04:07:56.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:9:0)
[04:07:56.300] Build status: STARTED
[04:07:56.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:10:0) after 6m58s
[04:14:54.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:10:0)
[04:14:54.344] Build status: STARTED
[04:14:54.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:11:0) after 2m51s
[04:17:45.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:11:0)
[04:17:45.604] Build status: STARTED
[04:17:45.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:12:0) after 7m59s
[04:25:44.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:12:0)
[04:25:44.657] Build status: STARTED
[04:25:44.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:13:0) after 4m58s
[04:30:42.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:13:0)
[04:30:42.776] Build status: STARTED
[04:30:42.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:14:0) after 8m43s
[04:39:25.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:14:0)
[04:39:25.886] Build status: STARTED
[04:39:25.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:15:0) after 7m4s
[04:46:30.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:15:0)
[04:46:30.039] Build status: STARTED
[04:46:30.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:16:0) after 5m4s
[04:51:34.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:16:0)
[04:51:34.134] Build status: STARTED
[04:51:34.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:17:0) after 4m8s
[04:55:42.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:17:0)
[04:55:42.192] Build status: STARTED
[04:55:42.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:18:0) after 3m17s
[04:58:59.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:18:0)
[04:58:59.252] Build status: STARTED
[04:58:59.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:19:0) after 6m4s
[05:05:03.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:19:0)
[05:05:03.862] Build status: STARTED
[05:05:03.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:20:0) after 4m33s
[05:09:36.894] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:20:0)
[05:09:36.930] Build status: STARTED
[05:09:36.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:21:0) after 1m7s
[05:10:43.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:21:0)
[05:10:44.009] Build status: STARTED
[05:10:44.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:22:0) after 3m46s
[05:14:30.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:22:0)
[05:14:30.170] Build status: STARTED
[05:14:30.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:23:0) after 4m20s
[05:18:50.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:23:0)
[05:18:50.212] Build status: STARTED
[05:18:50.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:24:0) after 8m56s
[05:27:46.343] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:24:0)
[05:27:46.365] Build status: STARTED
[05:27:46.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:25:0) after 9m30s
[05:37:16.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:25:0)
[05:37:16.539] Build status: STARTED
[05:37:16.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:26:0) after 3m51s
[05:41:07.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:26:0)
[05:41:07.672] Build status: STARTED
[05:41:07.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:27:0) after 5m14s
[05:46:21.698] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:27:0)
[05:46:21.732] Build status: STARTED
[05:46:21.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:28:0) after 1m33s
[05:47:54.765] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:28:0)
[05:47:54.812] Build status: STARTED
[05:47:54.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:29:0) after 2m11s
[05:50:05.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:29:0)
[05:50:05.881] Build status: STARTED
[05:50:05.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:30:0) after 2m28s
[05:52:33.921] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:30:0)
[05:52:33.951] Build status: STARTED
[05:52:33.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:31:0) after 7m1s
[05:59:35.040] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:31:0)
[05:59:35.066] Build status: STARTED
[05:59:35.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:32:0) after 2m22s
[06:01:57.092] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:32:0)
[06:01:57.132] Build status: STARTED
[06:01:57.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:33:0) after 8m56s
[06:10:53.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:33:0)
[06:10:53.246] Build status: STARTED
[06:10:53.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:34:0) after 6m6s
[06:16:59.573] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:34:0)
[06:16:59.600] Build status: STARTED
[06:16:59.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:35:0) after 7m6s
[06:24:05.988] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:35:0)
[06:24:06.018] Build status: STARTED
[06:24:06.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:36:0) after 4m30s
[06:28:36.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:36:0)
[06:28:36.085] Build status: STARTED
[06:28:36.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:37:0) after 4m53s
[06:33:29.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:37:0)
[06:33:29.139] Build status: STARTED
[06:33:29.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:38:0) after 6m53s
[06:40:22.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:38:0)
[06:40:22.255] Build status: STARTED
[06:40:22.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:39:0) after 1m56s
[06:42:18.266] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:39:0)
[06:42:18.331] Build status: STARTED
[06:42:18.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:40:0) after 3m0s
[06:45:18.455] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:40:0)
[06:45:18.531] Build status: STARTED
[06:45:18.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:41:0) after 6m19s
[06:51:37.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:41:0)
[06:51:37.695] Build status: STARTED
[06:51:37.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:42:0) after 3m56s
[06:55:33.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:42:0)
[06:55:33.742] Build status: STARTED
[06:55:33.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:43:0) after 6m49s
[07:02:22.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:43:0)
[07:02:22.816] Build status: STARTED
[07:02:22.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:44:0) after 8m1s
[07:10:23.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:44:0)
[07:10:23.913] Build status: STARTED
[07:10:23.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:45:0) after 8m13s
[07:18:36.984] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:45:0)
[07:18:37.008] Build status: STARTED
[07:18:37.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:46:0) after 9m1s
[07:27:38.055] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:46:0)
[07:27:38.086] Build status: STARTED
[07:27:38.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:47:0) after 1m20s
[07:28:58.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:47:0)
[07:28:58.114] Build status: STARTED
[07:28:58.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:48:0) after 4m59s
[07:33:57.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:48:0)
[07:33:57.213] Build status: STARTED
[07:33:57.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:49:0) after 7m9s
[07:41:06.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:49:0)
[07:41:06.382] Build status: STARTED
[07:41:06.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:50:0) after 6m45s
[07:47:51.431] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:50:0)
[07:47:51.470] Build status: STARTED
[07:47:51.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:51:0) after 1m20s
[07:49:11.481] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:51:0)
[07:49:11.523] Build status: STARTED
[07:49:11.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:52:0) after 5m9s
[07:54:20.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:52:0)
[07:54:20.712] Build status: STARTED
[07:54:20.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:53:0) after 3m0s
[07:57:20.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:53:0)
[07:57:20.944] Build status: STARTED
[07:57:20.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:54:0) after 7m58s
[08:05:19.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:54:0)
[08:05:19.164] Build status: STARTED
[08:05:19.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:55:0) after 6m37s
[08:11:56.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:55:0)
[08:11:56.259] Build status: STARTED
[08:11:56.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:56:0) after 8m34s
[08:20:30.328] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:56:0)
[08:20:30.367] Build status: STARTED
[08:20:30.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:57:0) after 3m3s
[08:23:33.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:57:0)
[08:23:33.705] Build status: STARTED
[08:23:33.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:58:0) after 4m27s
[08:28:00.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:58:0)
[08:28:00.761] Build status: STARTED
[08:28:00.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:59:0) after 8m26s
[08:36:26.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:59:0)
[08:36:26.992] Build status: STARTED
[08:36:26.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:60:0) after 8m47s
[08:45:14.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:60:0)
[08:45:14.074] Build status: STARTED
[08:45:14.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:61:0) after 6m46s
[08:52:00.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:61:0)
[08:52:00.132] Build status: STARTED
[08:52:00.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:62:0) after 1m39s
[08:53:39.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:62:0)
[08:53:39.272] Build status: STARTED
[08:53:39.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:63:0) after 8m33s
[09:02:12.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:63:0)
[09:02:12.377] Build status: STARTED
[09:02:12.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:64:0) after 9m37s
[09:11:49.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:64:0)
[09:11:49.432] Build status: STARTED
[09:11:49.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:65:0) after 3m37s
[09:15:26.483] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:65:0)
[09:15:26.505] Build status: STARTED
[09:15:26.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:66:0) after 7m52s
[09:23:18.545] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:66:0)
[09:23:18.572] Build status: STARTED
[09:23:18.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:67:0) after 4m57s
[09:28:15.817] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:67:0)
[09:28:15.856] Build status: STARTED
[09:28:15.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:68:0) after 9m14s
[09:37:29.933] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:68:0)
[09:37:29.958] Build status: STARTED
[09:37:29.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:69:0) after 2m39s
[09:40:09.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:69:0)
[09:40:09.132] Build status: STARTED
[09:40:09.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:70:0) after 8m40s
[09:48:49.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:70:0)
[09:48:49.300] Build status: STARTED
[09:48:49.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:71:0) after 2m14s
[09:51:03.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:71:0)
[09:51:03.371] Build status: STARTED
[09:51:03.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:72:0) after 8m30s
[09:59:33.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:72:0)
[09:59:33.450] Build status: STARTED
[09:59:33.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:73:0) after 9m6s
[10:08:39.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:73:0)
[10:08:39.849] Build status: STARTED
[10:08:39.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:74:0) after 6m0s
[10:14:39.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:74:0)
[10:14:39.985] Build status: STARTED
[10:14:39.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:75:0) after 7m0s
[10:21:40.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:75:0)
[10:21:40.139] Build status: STARTED
[10:21:40.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:76:0) after 9m32s
[10:31:12.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:76:0)
[10:31:12.621] Build status: STARTED
[10:31:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:77:0) after 9m14s
[10:40:26.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:77:0)
[10:40:26.696] Build status: STARTED
[10:40:26.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:78:0) after 9m17s
[10:49:43.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:78:0)
[10:49:43.806] Build status: STARTED
[10:49:43.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:79:0) after 6m21s
[10:56:04.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:79:0)
[10:56:04.931] Build status: STARTED
[10:56:04.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:80:0) after 8m0s
[11:04:05.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:80:0)
[11:04:05.031] Build status: STARTED
[11:04:05.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:81:0) after 8m14s
[11:12:19.259] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:81:0)
[11:12:19.293] Build status: STARTED
[11:12:19.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:82:0) after 4m18s
[11:16:37.360] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:82:0)
[11:16:37.435] Build status: STARTED
[11:16:37.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:83:0) after 5m30s
[11:22:07.669] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:83:0)
[11:22:07.691] Build status: STARTED
[11:22:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:84:0) after 3m8s
[11:25:15.731] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:84:0)
[11:25:15.768] Build status: STARTED
[11:25:15.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:85:0) after 4m55s
[11:30:11.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:85:0)
[11:30:11.027] Build status: STARTED
[11:30:11.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:86:0) after 6m0s
[11:36:11.057] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:86:0)
[11:36:11.084] Build status: STARTED
[11:36:11.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:87:0) after 5m27s
[11:41:38.188] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:87:0)
[11:41:38.209] Build status: STARTED
[11:41:38.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:88:0) after 2m50s
[11:44:28.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:88:0)
[11:44:28.480] Build status: STARTED
[11:44:28.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:89:0) after 9m53s
[11:54:21.511] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:89:0)
[11:54:21.549] Build status: STARTED
[11:54:21.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:90:0) after 6m16s
[12:00:37.580] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:90:0)
[12:00:37.613] Build status: STARTED
[12:00:37.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:91:0) after 1m35s
[12:02:12.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:91:0)
[12:02:12.841] Build status: STARTED
[12:02:12.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:92:0) after 7m51s
[12:10:04.039] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:92:0)
[12:10:04.063] Build status: STARTED
[12:10:04.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:93:0) after 8m36s
[12:18:40.092] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:93:0)
[12:18:40.124] Build status: STARTED
[12:18:40.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:94:0) after 6m43s
[12:25:23.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:94:0)
[12:25:23.595] Build status: STARTED
[12:25:23.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:95:0) after 4m52s
[12:30:15.661] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:95:0)
[12:30:15.692] Build status: STARTED
[12:30:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:96:0) after 9m11s
[12:39:26.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:96:0)
[12:39:26.838] Build status: STARTED
[12:39:26.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:97:0) after 3m35s
[12:43:02.152] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:97:0)
[12:43:02.172] Build status: STARTED
[12:43:02.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:98:0) after 1m39s
[12:44:41.256] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:98:0)
[12:44:41.279] Build status: STARTED
[12:44:41.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:99:0) after 8m27s
[12:53:08.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:99:0)
[12:53:08.339] Build status: STARTED
[12:53:08.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:100:0) after 7m40s
[13:00:48.378] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:100:0)
[13:00:48.446] Build status: STARTED
[13:00:48.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:101:0) after 1m10s
[13:01:58.728] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:101:0)
[13:01:58.767] Build status: STARTED
[13:01:58.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8979833498692524160:102:0) after 7m35s
[13:03:47.951] Received PubSub notification, asking Buildbucket for the build status
[13:03:47.970] Build:
{
"id": "8814403436638069361",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 1496,
"createdBy": "project:chromium",
"createTime": "2022-05-12T03:40:50.243567797Z",
"startTime": "2022-05-12T03:41:51.325942Z",
"endTime": "2022-05-12T13:03:47.506815781Z",
"updateTime": "2022-05-12T13:03:47.506815781Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8834821f452a3d424edd0ed2a1e9ceeda38d0ea",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:03:47.970] Invocation finished in 9h22m59.069491248s with status FAILED