[20:40:40.087] New invocation is queued and will start shortly
[20:40:41.265] Starting the invocation (attempt 1)
[20:40:41.303] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8287cc701420273143029303e3c1066030ab444"
[20:40:41.303] Popped gitiles commit info from properties and tags
[20:40:41.303] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:40:41.303] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:40:41.303] Buildbucket request:
{
"requestId": "8993721267922504720",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8287cc701420273143029303e3c1066030ab444",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8993721267922504720"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:40:42.017] Scheduled build:
{
"id": "8828291205896514001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 27995,
"createdBy": "project:chromium",
"createTime": "2021-12-09T20:40:41.389068645Z",
"updateTime": "2021-12-09T20:40:41.389068645Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8287cc701420273143029303e3c1066030ab444",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:40:42.017] Task URL: https://cr-buildbucket.appspot.com/build/8828291205896514001
[20:40:42.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:2:0) after 7m33s
[20:48:15.359] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:2:0)
[20:48:15.419] Build status: SCHEDULED
[20:48:15.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:3:0) after 3m30s
[20:51:45.443] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:3:0)
[20:51:45.465] Build status: SCHEDULED
[20:51:45.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:4:0) after 1m51s
[20:53:36.493] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:4:0)
[20:53:36.513] Build status: SCHEDULED
[20:53:36.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:5:0) after 6m20s
[20:59:56.929] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:5:0)
[20:59:56.953] Build status: SCHEDULED
[20:59:56.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:6:0) after 8m2s
[21:06:04.833] Received PubSub notification, asking Buildbucket for the build status
[21:06:04.911] Build status: STARTED
[21:07:59.126] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:6:0)
[21:07:59.177] Build status: STARTED
[21:07:59.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:8:0) after 6m29s
[21:14:28.256] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:8:0)
[21:14:28.279] Build status: STARTED
[21:14:28.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:9:0) after 5m25s
[21:19:53.324] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:9:0)
[21:19:53.354] Build status: STARTED
[21:19:53.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:10:0) after 9m39s
[21:29:32.581] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:10:0)
[21:29:32.601] Build status: STARTED
[21:29:32.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:11:0) after 9m59s
[21:39:31.974] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:11:0)
[21:39:32.003] Build status: STARTED
[21:39:32.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:12:0) after 8m14s
[21:47:46.029] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:12:0)
[21:47:46.072] Build status: STARTED
[21:47:46.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:13:0) after 7m46s
[21:55:32.100] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:13:0)
[21:55:32.145] Build status: STARTED
[21:55:32.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:14:0) after 4m28s
[22:00:00.389] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:14:0)
[22:00:00.413] Build status: STARTED
[22:00:00.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:15:0) after 4m52s
[22:04:52.456] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:15:0)
[22:04:52.477] Build status: STARTED
[22:04:52.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:16:0) after 4m1s
[22:08:53.664] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:16:0)
[22:08:53.684] Build status: STARTED
[22:08:53.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:17:0) after 8m1s
[22:16:55.233] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:17:0)
[22:16:55.255] Build status: STARTED
[22:16:55.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:18:0) after 3m25s
[22:20:20.383] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:18:0)
[22:20:20.471] Build status: STARTED
[22:20:20.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:19:0) after 9m7s
[22:29:27.532] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:19:0)
[22:29:27.552] Build status: STARTED
[22:29:27.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:20:0) after 3m39s
[22:33:06.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:20:0)
[22:33:06.631] Build status: STARTED
[22:33:06.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:21:0) after 3m30s
[22:36:36.663] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:21:0)
[22:36:36.698] Build status: STARTED
[22:36:36.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:22:0) after 6m59s
[22:43:35.724] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:22:0)
[22:43:35.754] Build status: STARTED
[22:43:35.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:23:0) after 3m29s
[22:47:04.817] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:23:0)
[22:47:04.842] Build status: STARTED
[22:47:04.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:24:0) after 2m25s
[22:49:29.870] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:24:0)
[22:49:29.904] Build status: STARTED
[22:49:29.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:25:0) after 2m17s
[22:51:47.098] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:25:0)
[22:51:47.121] Build status: STARTED
[22:51:47.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:26:0) after 2m8s
[22:53:55.147] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:26:0)
[22:53:55.188] Build status: STARTED
[22:53:55.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:27:0) after 2m14s
[22:56:09.351] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:27:0)
[22:56:09.409] Build status: STARTED
[22:56:09.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:28:0) after 3m45s
[22:59:54.719] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:28:0)
[22:59:54.741] Build status: STARTED
[22:59:54.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:29:0) after 3m49s
[23:03:43.870] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:29:0)
[23:03:43.895] Build status: STARTED
[23:03:43.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:30:0) after 2m9s
[23:05:52.924] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:30:0)
[23:05:52.947] Build status: STARTED
[23:05:52.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:31:0) after 5m4s
[23:10:56.977] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:31:0)
[23:10:57.015] Build status: STARTED
[23:10:57.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:32:0) after 6m28s
[23:17:25.133] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:32:0)
[23:17:25.169] Build status: STARTED
[23:17:25.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:33:0) after 2m3s
[23:19:28.332] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:33:0)
[23:19:28.362] Build status: STARTED
[23:19:28.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:34:0) after 2m49s
[23:22:17.420] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:34:0)
[23:22:17.459] Build status: STARTED
[23:22:17.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:35:0) after 9m12s
[23:31:29.488] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:35:0)
[23:31:29.509] Build status: STARTED
[23:31:29.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:36:0) after 1m43s
[23:33:12.534] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:36:0)
[23:33:12.553] Build status: STARTED
[23:33:12.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:37:0) after 8m17s
[23:41:29.576] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:37:0)
[23:41:29.601] Build status: STARTED
[23:41:29.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:38:0) after 5m45s
[23:47:14.688] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:38:0)
[23:47:14.725] Build status: STARTED
[23:47:14.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:39:0) after 4m48s
[23:52:02.762] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:39:0)
[23:52:02.796] Build status: STARTED
[23:52:02.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:40:0) after 3m26s
[23:55:28.783] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:40:0)
[23:55:28.811] Build status: STARTED
[23:55:28.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:41:0) after 7m24s
[00:02:52.833] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:41:0)
[00:02:52.909] Build status: STARTED
[00:02:52.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:42:0) after 7m2s
[00:09:55.004] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:42:0)
[00:09:55.032] Build status: STARTED
[00:09:55.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:43:0) after 8m29s
[00:18:24.062] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:43:0)
[00:18:24.092] Build status: STARTED
[00:18:24.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:44:0) after 5m27s
[00:23:51.269] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:44:0)
[00:23:51.299] Build status: STARTED
[00:23:51.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:45:0) after 4m11s
[00:28:02.282] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:45:0)
[00:28:02.312] Build status: STARTED
[00:28:02.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:46:0) after 2m56s
[00:30:58.547] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:46:0)
[00:30:58.580] Build status: STARTED
[00:30:58.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:47:0) after 8m45s
[00:39:43.608] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:47:0)
[00:39:43.643] Build status: STARTED
[00:39:43.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:48:0) after 7m59s
[00:47:42.668] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:48:0)
[00:47:42.689] Build status: STARTED
[00:47:42.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:49:0) after 3m39s
[00:51:21.714] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:49:0)
[00:51:21.742] Build status: STARTED
[00:51:21.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:50:0) after 9m11s
[01:00:32.805] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:50:0)
[01:00:32.856] Build status: STARTED
[01:00:32.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:51:0) after 4m58s
[01:05:30.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:51:0)
[01:05:30.911] Build status: STARTED
[01:05:30.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:52:0) after 2m19s
[01:07:50.250] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:52:0)
[01:07:50.281] Build status: STARTED
[01:07:50.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:53:0) after 1m54s
[01:09:44.413] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:53:0)
[01:09:44.454] Build status: STARTED
[01:09:44.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:54:0) after 1m16s
[01:11:00.639] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:54:0)
[01:11:00.659] Build status: STARTED
[01:11:00.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:55:0) after 1m37s
[01:12:37.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:55:0)
[01:12:37.756] Build status: STARTED
[01:12:37.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:56:0) after 5m50s
[01:18:27.785] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:56:0)
[01:18:27.806] Build status: STARTED
[01:18:27.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:57:0) after 2m24s
[01:20:51.783] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:57:0)
[01:20:51.815] Build status: STARTED
[01:20:51.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:58:0) after 5m40s
[01:26:31.967] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:58:0)
[01:26:32.008] Build status: STARTED
[01:26:32.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:59:0) after 6m35s
[01:33:07.287] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:59:0)
[01:33:07.325] Build status: STARTED
[01:33:07.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:60:0) after 6m33s
[01:39:40.362] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:60:0)
[01:39:40.387] Build status: STARTED
[01:39:40.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:61:0) after 2m36s
[01:42:16.644] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:61:0)
[01:42:16.679] Build status: STARTED
[01:42:16.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:62:0) after 4m50s
[01:47:06.719] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:62:0)
[01:47:06.741] Build status: STARTED
[01:47:06.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:63:0) after 3m40s
[01:50:46.772] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:63:0)
[01:50:46.833] Build status: STARTED
[01:50:46.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:64:0) after 7m57s
[01:58:43.973] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:64:0)
[01:58:44.006] Build status: STARTED
[01:58:44.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:65:0) after 5m7s
[02:03:51.191] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:65:0)
[02:03:51.212] Build status: STARTED
[02:03:51.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:66:0) after 1m2s
[02:04:53.358] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:66:0)
[02:04:53.380] Build status: STARTED
[02:04:53.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:67:0) after 7m13s
[02:12:06.553] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:67:0)
[02:12:06.573] Build status: STARTED
[02:12:06.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:68:0) after 3m47s
[02:15:53.605] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:68:0)
[02:15:53.670] Build status: STARTED
[02:15:53.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:69:0) after 1m36s
[02:17:29.704] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:69:0)
[02:17:29.727] Build status: STARTED
[02:17:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:70:0) after 6m32s
[02:24:01.776] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:70:0)
[02:24:01.797] Build status: STARTED
[02:24:01.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:71:0) after 1m18s
[02:25:19.961] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:71:0)
[02:25:19.986] Build status: STARTED
[02:25:19.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:72:0) after 3m55s
[02:29:15.014] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:72:0)
[02:29:15.037] Build status: STARTED
[02:29:15.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:73:0) after 5m31s
[02:34:46.067] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:73:0)
[02:34:46.102] Build status: STARTED
[02:34:46.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:74:0) after 4m19s
[02:39:05.135] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:74:0)
[02:39:05.166] Build status: STARTED
[02:39:05.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:75:0) after 7m45s
[02:46:50.599] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:75:0)
[02:46:50.625] Build status: STARTED
[02:46:50.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:76:0) after 2m53s
[02:49:43.674] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:76:0)
[02:49:43.696] Build status: STARTED
[02:49:43.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:77:0) after 3m17s
[02:53:00.793] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:77:0)
[02:53:00.831] Build status: STARTED
[02:53:00.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:78:0) after 8m43s
[03:01:43.930] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:78:0)
[03:01:43.952] Build status: STARTED
[03:01:43.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:79:0) after 1m9s
[03:02:52.984] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:79:0)
[03:02:53.021] Build status: STARTED
[03:02:53.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:80:0) after 7m11s
[03:10:04.049] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:80:0)
[03:10:04.070] Build status: STARTED
[03:10:04.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:81:0) after 6m5s
[03:16:09.149] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:81:0)
[03:16:09.169] Build status: STARTED
[03:16:09.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:82:0) after 7m7s
[03:23:16.300] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:82:0)
[03:23:16.322] Build status: STARTED
[03:23:16.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:83:0) after 7m7s
[03:30:23.421] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:83:0)
[03:30:23.447] Build status: STARTED
[03:30:23.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:84:0) after 8m49s
[03:39:12.548] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:84:0)
[03:39:12.573] Build status: STARTED
[03:39:12.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:85:0) after 1m26s
[03:40:38.704] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:85:0)
[03:40:38.728] Build status: STARTED
[03:40:38.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:86:0) after 1m15s
[03:41:53.757] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:86:0)
[03:41:53.792] Build status: STARTED
[03:41:53.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:87:0) after 1m31s
[03:43:24.824] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:87:0)
[03:43:24.858] Build status: STARTED
[03:43:24.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:88:0) after 8m43s
[03:52:07.891] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:88:0)
[03:52:07.911] Build status: STARTED
[03:52:07.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:89:0) after 3m25s
[03:55:33.070] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:89:0)
[03:55:33.093] Build status: STARTED
[03:55:33.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:90:0) after 8m33s
[04:04:06.255] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:90:0)
[04:04:06.278] Build status: STARTED
[04:04:06.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:91:0) after 4m10s
[04:08:16.310] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:91:0)
[04:08:16.336] Build status: STARTED
[04:08:16.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:92:0) after 5m35s
[04:13:51.377] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:92:0)
[04:13:51.415] Build status: STARTED
[04:13:51.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:93:0) after 9m22s
[04:23:13.563] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:93:0)
[04:23:13.614] Build status: STARTED
[04:23:13.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:94:0) after 3m33s
[04:26:46.779] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:94:0)
[04:26:46.799] Build status: STARTED
[04:26:46.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:95:0) after 7m50s
[04:34:36.913] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:95:0)
[04:34:36.935] Build status: STARTED
[04:34:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:96:0) after 7m5s
[04:41:42.232] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:96:0)
[04:41:42.266] Build status: STARTED
[04:41:42.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:97:0) after 9m35s
[04:51:17.290] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:97:0)
[04:51:17.327] Build status: STARTED
[04:51:17.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:98:0) after 3m58s
[04:55:15.349] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:98:0)
[04:55:15.371] Build status: STARTED
[04:55:15.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:99:0) after 5m59s
[05:01:14.538] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:99:0)
[05:01:14.568] Build status: STARTED
[05:01:14.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:100:0) after 6m21s
[05:07:35.604] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:100:0)
[05:07:35.626] Build status: STARTED
[05:07:35.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:101:0) after 5m29s
[05:13:04.652] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:101:0)
[05:13:04.696] Build status: STARTED
[05:13:04.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:102:0) after 2m13s
[05:15:17.745] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:102:0)
[05:15:17.781] Build status: STARTED
[05:15:17.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:103:0) after 3m9s
[05:18:26.809] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:103:0)
[05:18:26.837] Build status: STARTED
[05:18:26.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:104:0) after 3m10s
[05:21:36.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:104:0)
[05:21:36.956] Build status: STARTED
[05:21:36.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:105:0) after 4m50s
[05:26:27.288] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:105:0)
[05:26:28.227] Build status: STARTED
[05:26:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:106:0) after 4m46s
[05:31:14.273] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:106:0)
[05:31:14.489] Build status: STARTED
[05:31:14.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:107:0) after 1m7s
[05:32:21.558] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:107:0)
[05:32:21.579] Build status: STARTED
[05:32:21.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:108:0) after 5m21s
[05:37:42.684] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:108:0)
[05:37:42.707] Build status: STARTED
[05:37:42.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:109:0) after 4m1s
[05:41:43.741] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:109:0)
[05:41:43.763] Build status: STARTED
[05:41:43.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:110:0) after 3m12s
[05:44:55.792] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:110:0)
[05:44:55.811] Build status: STARTED
[05:44:55.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:111:0) after 5m20s
[05:50:15.961] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:111:0)
[05:50:15.981] Build status: STARTED
[05:50:15.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:112:0) after 6m22s
[05:56:38.011] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:112:0)
[05:56:38.044] Build status: STARTED
[05:56:38.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:113:0) after 8m12s
[06:04:50.085] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:113:0)
[06:04:50.106] Build status: STARTED
[06:04:50.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:114:0) after 7m0s
[06:11:50.175] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:114:0)
[06:11:50.195] Build status: STARTED
[06:11:50.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:115:0) after 5m1s
[06:16:51.230] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:115:0)
[06:16:51.261] Build status: STARTED
[06:16:51.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8993721267922504720:116:0) after 8m19s
[06:19:52.514] Received PubSub notification, asking Buildbucket for the build status
[06:19:52.538] Build:
{
"id": "8828291205896514001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 27995,
"createdBy": "project:chromium",
"createTime": "2021-12-09T20:40:41.389068645Z",
"startTime": "2021-12-09T21:06:04.110598Z",
"endTime": "2021-12-10T06:19:48.597806537Z",
"updateTime": "2021-12-10T06:19:48.597806537Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c8287cc701420273143029303e3c1066030ab444",
"ref": "refs/heads/main"
}
},
"canary": true
}
[06:19:52.538] Invocation finished in 9h39m12.465125796s with status SUCCEEDED