[02:52:46.626] New invocation is queued and will start shortly
[02:52:47.937] Starting the invocation (attempt 1)
[02:52:47.978] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a2049c2c5edb1e9026b5707a7e22a87a6bbd73d"
[02:52:47.978] Popped gitiles commit info from properties and tags
[02:52:47.978] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:52:47.978] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:52:47.978] Buildbucket request:
{
"requestId": "8985997114708923472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4a2049c2c5edb1e9026b5707a7e22a87a6bbd73d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8985997114708923472"
},
{
"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"
}
}
[02:52:48.642] Scheduled build:
{
"id": "8820567052552281185",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 1151,
"createdBy": "project:chromium",
"createTime": "2022-03-05T02:52:48.049327549Z",
"updateTime": "2022-03-05T02:52:48.049327549Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4a2049c2c5edb1e9026b5707a7e22a87a6bbd73d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[02:52:48.642] Task URL: https://cr-buildbucket.appspot.com/build/8820567052552281185
[02:52:48.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:2:0) after 1m4s
[02:53:52.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:2:0)
[02:53:52.857] Build status: SCHEDULED
[02:53:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:3:0) after 8m18s
[03:02:10.887] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:3:0)
[03:02:10.905] Build status: SCHEDULED
[03:02:10.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:4:0) after 4m30s
[03:06:40.929] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:4:0)
[03:06:40.949] Build status: SCHEDULED
[03:06:40.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:5:0) after 1m40s
[03:08:21.015] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:5:0)
[03:08:21.036] Build status: SCHEDULED
[03:08:21.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:6:0) after 6m57s
[03:15:18.089] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:6:0)
[03:15:18.114] Build status: SCHEDULED
[03:15:18.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:7:0) after 6m48s
[03:22:06.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:7:0)
[03:22:06.186] Build status: SCHEDULED
[03:22:06.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:8:0) after 7m18s
[03:29:24.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:8:0)
[03:29:24.260] Build status: SCHEDULED
[03:29:24.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:9:0) after 6m35s
[03:35:59.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:9:0)
[03:35:59.353] Build status: SCHEDULED
[03:35:59.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:10:0) after 6m23s
[03:42:22.382] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:10:0)
[03:42:22.411] Build status: SCHEDULED
[03:42:22.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:11:0) after 7m51s
[03:50:13.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:11:0)
[03:50:13.471] Build status: SCHEDULED
[03:50:13.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:12:0) after 6m7s
[03:56:20.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:12:0)
[03:56:20.600] Build status: SCHEDULED
[03:56:20.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:13:0) after 7m28s
[04:03:48.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:13:0)
[04:03:48.647] Build status: SCHEDULED
[04:03:48.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:14:0) after 2m20s
[04:06:08.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:14:0)
[04:06:08.728] Build status: SCHEDULED
[04:06:08.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:15:0) after 4m33s
[04:06:31.747] Received PubSub notification, asking Buildbucket for the build status
[04:06:31.778] Build status: STARTED
[04:10:41.762] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:15:0)
[04:10:41.785] Build status: STARTED
[04:10:41.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:17:0) after 9m10s
[04:19:51.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:17:0)
[04:19:51.868] Build status: STARTED
[04:19:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:18:0) after 8m57s
[04:28:49.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:18:0)
[04:28:49.049] Build status: STARTED
[04:28:49.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:19:0) after 8m25s
[04:37:14.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:19:0)
[04:37:14.391] Build status: STARTED
[04:37:14.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:20:0) after 9m11s
[04:46:25.634] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:20:0)
[04:46:25.659] Build status: STARTED
[04:46:25.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:21:0) after 9m12s
[04:55:37.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:21:0)
[04:55:37.739] Build status: STARTED
[04:55:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:22:0) after 8m32s
[05:04:09.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:22:0)
[05:04:09.999] Build status: STARTED
[05:04:09.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:23:0) after 4m4s
[05:08:14.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:23:0)
[05:08:14.195] Build status: STARTED
[05:08:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:24:0) after 5m20s
[05:13:34.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:24:0)
[05:13:34.400] Build status: STARTED
[05:13:34.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:25:0) after 5m36s
[05:19:10.410] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:25:0)
[05:19:10.444] Build status: STARTED
[05:19:10.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:26:0) after 9m12s
[05:28:22.670] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:26:0)
[05:28:22.692] Build status: STARTED
[05:28:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:27:0) after 2m36s
[05:30:59.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:27:0)
[05:30:59.076] Build status: STARTED
[05:30:59.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:28:0) after 2m55s
[05:33:54.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:28:0)
[05:33:54.140] Build status: STARTED
[05:33:54.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:29:0) after 2m40s
[05:36:34.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:29:0)
[05:36:34.345] Build status: STARTED
[05:36:34.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:30:0) after 9m45s
[05:46:19.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:30:0)
[05:46:19.463] Build status: STARTED
[05:46:19.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:31:0) after 4m40s
[05:50:59.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:31:0)
[05:50:59.550] Build status: STARTED
[05:50:59.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:32:0) after 7m41s
[05:58:40.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:32:0)
[05:58:40.688] Build status: STARTED
[05:58:40.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:33:0) after 8m12s
[06:06:52.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:33:0)
[06:06:52.745] Build status: STARTED
[06:06:52.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:34:0) after 8m59s
[06:15:51.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:34:0)
[06:15:51.809] Build status: STARTED
[06:15:51.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:35:0) after 2m49s
[06:18:41.092] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:35:0)
[06:18:41.115] Build status: STARTED
[06:18:41.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:36:0) after 4m47s
[06:23:28.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:36:0)
[06:23:28.175] Build status: STARTED
[06:23:28.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:37:0) after 3m31s
[06:26:59.218] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:37:0)
[06:26:59.246] Build status: STARTED
[06:26:59.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:38:0) after 6m29s
[06:33:28.420] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:38:0)
[06:33:28.440] Build status: STARTED
[06:33:28.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:39:0) after 1m23s
[06:34:51.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:39:0)
[06:34:51.513] Build status: STARTED
[06:34:51.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:40:0) after 3m16s
[06:38:07.546] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:40:0)
[06:38:07.579] Build status: STARTED
[06:38:07.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:41:0) after 8m22s
[06:46:29.608] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:41:0)
[06:46:29.629] Build status: STARTED
[06:46:29.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:42:0) after 3m22s
[06:49:51.993] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:42:0)
[06:49:52.021] Build status: STARTED
[06:49:52.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:43:0) after 3m37s
[06:53:29.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:43:0)
[06:53:29.109] Build status: STARTED
[06:53:29.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:44:0) after 2m38s
[06:56:07.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:44:0)
[06:56:07.170] Build status: STARTED
[06:56:07.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:45:0) after 6m56s
[07:03:03.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:45:0)
[07:03:03.328] Build status: STARTED
[07:03:03.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:46:0) after 9m3s
[07:12:06.465] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:46:0)
[07:12:06.535] Build status: STARTED
[07:12:06.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:47:0) after 4m41s
[07:16:47.640] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:47:0)
[07:16:47.661] Build status: STARTED
[07:16:47.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:48:0) after 3m22s
[07:20:09.671] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:48:0)
[07:20:09.703] Build status: STARTED
[07:20:09.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:49:0) after 1m33s
[07:21:42.882] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:49:0)
[07:21:42.921] Build status: STARTED
[07:21:42.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:50:0) after 9m3s
[07:30:46.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:50:0)
[07:30:46.215] Build status: STARTED
[07:30:46.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:51:0) after 1m16s
[07:32:02.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:51:0)
[07:32:02.264] Build status: STARTED
[07:32:02.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:52:0) after 1m36s
[07:33:38.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:52:0)
[07:33:38.387] Build status: STARTED
[07:33:38.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:53:0) after 9m46s
[07:43:24.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:53:0)
[07:43:24.473] Build status: STARTED
[07:43:24.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:54:0) after 4m18s
[07:47:42.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:54:0)
[07:47:42.546] Build status: STARTED
[07:47:42.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:55:0) after 9m26s
[07:57:08.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:55:0)
[07:57:08.758] Build status: STARTED
[07:57:08.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:56:0) after 7m51s
[08:04:59.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:56:0)
[08:04:59.849] Build status: STARTED
[08:04:59.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:57:0) after 9m31s
[08:14:30.841] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:57:0)
[08:14:30.882] Build status: STARTED
[08:14:30.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:58:0) after 6m35s
[08:21:05.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:58:0)
[08:21:05.961] Build status: STARTED
[08:21:05.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:59:0) after 6m21s
[08:27:27.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:59:0)
[08:27:27.124] Build status: STARTED
[08:27:27.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:60:0) after 9m41s
[08:37:08.196] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:60:0)
[08:37:08.244] Build status: STARTED
[08:37:08.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:61:0) after 5m32s
[08:42:40.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:61:0)
[08:42:40.410] Build status: STARTED
[08:42:40.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:62:0) after 5m21s
[08:48:01.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:62:0)
[08:48:01.604] Build status: STARTED
[08:48:01.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:63:0) after 1m16s
[08:49:17.638] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:63:0)
[08:49:17.661] Build status: STARTED
[08:49:17.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:64:0) after 8m33s
[08:57:50.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:64:0)
[08:57:50.807] Build status: STARTED
[08:57:50.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:65:0) after 9m55s
[09:07:45.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:65:0)
[09:07:45.855] Build status: STARTED
[09:07:45.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:66:0) after 8m17s
[09:16:03.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:66:0)
[09:16:03.125] Build status: STARTED
[09:16:03.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:67:0) after 4m27s
[09:20:30.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:67:0)
[09:20:30.236] Build status: STARTED
[09:20:30.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:68:0) after 7m51s
[09:28:21.272] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:68:0)
[09:28:21.303] Build status: STARTED
[09:28:21.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:69:0) after 9m19s
[09:37:40.341] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:69:0)
[09:37:40.375] Build status: STARTED
[09:37:40.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:70:0) after 2m57s
[09:40:37.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:70:0)
[09:40:37.490] Build status: STARTED
[09:40:37.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:71:0) after 9m55s
[09:50:32.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:71:0)
[09:50:32.556] Build status: STARTED
[09:50:32.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:72:0) after 3m26s
[09:53:58.691] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:72:0)
[09:53:58.726] Build status: STARTED
[09:53:58.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:73:0) after 9m57s
[10:03:55.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:73:0)
[10:03:55.790] Build status: STARTED
[10:03:55.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:74:0) after 1m53s
[10:05:48.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:74:0)
[10:05:48.884] Build status: STARTED
[10:05:48.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:75:0) after 6m43s
[10:12:32.572] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:75:0)
[10:12:32.606] Build status: STARTED
[10:12:32.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:76:0) after 2m29s
[10:15:02.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:76:0)
[10:15:02.745] Build status: STARTED
[10:15:02.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:77:0) after 6m18s
[10:21:20.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:77:0)
[10:21:20.806] Build status: STARTED
[10:21:20.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:78:0) after 4m41s
[10:26:02.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:78:0)
[10:26:02.236] Build status: STARTED
[10:26:02.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:79:0) after 7m9s
[10:33:11.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:79:0)
[10:33:11.345] Build status: STARTED
[10:33:11.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:80:0) after 3m0s
[10:36:11.431] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:80:0)
[10:36:11.467] Build status: STARTED
[10:36:11.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:81:0) after 3m45s
[10:39:56.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:81:0)
[10:39:56.516] Build status: STARTED
[10:39:56.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:82:0) after 8m26s
[10:48:22.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:82:0)
[10:48:22.620] Build status: STARTED
[10:48:22.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:83:0) after 9m23s
[10:57:45.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:83:0)
[10:57:45.789] Build status: STARTED
[10:57:45.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:84:0) after 1m21s
[10:59:06.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:84:0)
[10:59:06.866] Build status: STARTED
[10:59:06.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:85:0) after 2m6s
[11:01:12.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:85:0)
[11:01:12.974] Build status: STARTED
[11:01:12.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:86:0) after 9m45s
[11:10:58.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:86:0)
[11:10:58.065] Build status: STARTED
[11:10:58.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:87:0) after 7m4s
[11:18:02.099] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:87:0)
[11:18:02.124] Build status: STARTED
[11:18:02.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:88:0) after 1m34s
[11:19:36.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:88:0)
[11:19:36.265] Build status: STARTED
[11:19:36.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:89:0) after 5m20s
[11:24:56.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:89:0)
[11:24:56.327] Build status: STARTED
[11:24:56.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:90:0) after 3m3s
[11:27:59.560] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:90:0)
[11:27:59.667] Build status: STARTED
[11:27:59.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:91:0) after 7m39s
[11:35:38.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:91:0)
[11:35:38.775] Build status: STARTED
[11:35:38.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:92:0) after 9m44s
[11:45:22.817] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:92:0)
[11:45:22.897] Build status: STARTED
[11:45:22.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:93:0) after 4m15s
[11:49:37.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:93:0)
[11:49:37.967] Build status: STARTED
[11:49:37.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:94:0) after 3m45s
[11:53:23.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:94:0)
[11:53:23.051] Build status: STARTED
[11:53:23.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:95:0) after 1m12s
[11:54:35.088] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:95:0)
[11:54:35.116] Build status: STARTED
[11:54:35.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:96:0) after 8m43s
[12:03:18.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:96:0)
[12:03:18.180] Build status: STARTED
[12:03:18.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:97:0) after 8m46s
[12:12:04.411] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:97:0)
[12:12:04.438] Build status: STARTED
[12:12:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:98:0) after 3m25s
[12:15:29.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:98:0)
[12:15:29.614] Build status: STARTED
[12:15:29.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:99:0) after 4m48s
[12:20:17.643] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:99:0)
[12:20:17.686] Build status: STARTED
[12:20:17.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:100:0) after 7m12s
[12:27:30.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:100:0)
[12:27:30.041] Build status: STARTED
[12:27:30.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:101:0) after 5m18s
[12:32:48.158] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:101:0)
[12:32:48.186] Build status: STARTED
[12:32:48.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:102:0) after 3m2s
[12:35:50.342] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:102:0)
[12:35:50.366] Build status: STARTED
[12:35:50.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:103:0) after 5m45s
[12:41:35.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:103:0)
[12:41:35.423] Build status: STARTED
[12:41:35.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:104:0) after 2m27s
[12:44:02.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:104:0)
[12:44:02.497] Build status: STARTED
[12:44:02.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:105:0) after 9m52s
[12:53:54.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:105:0)
[12:53:54.935] Build status: STARTED
[12:53:54.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:106:0) after 7m50s
[13:01:45.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:106:0)
[13:01:45.650] Build status: STARTED
[13:01:45.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:107:0) after 5m28s
[13:07:13.688] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:107:0)
[13:07:13.710] Build status: STARTED
[13:07:13.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:108:0) after 5m30s
[13:12:43.740] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:108:0)
[13:12:43.766] Build status: STARTED
[13:12:43.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:109:0) after 2m51s
[13:15:34.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:109:0)
[13:15:34.838] Build status: STARTED
[13:15:34.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:110:0) after 2m19s
[13:17:53.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:110:0)
[13:17:53.907] Build status: STARTED
[13:17:53.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:111:0) after 5m11s
[13:23:05.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:111:0)
[13:23:05.086] Build status: STARTED
[13:23:05.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:112:0) after 3m24s
[13:26:29.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:112:0)
[13:26:29.474] Build status: STARTED
[13:26:29.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8985997114708923472:113:0) after 9m45s
[13:28:15.051] Received PubSub notification, asking Buildbucket for the build status
[13:28:15.081] Build:
{
"id": "8820567052552281185",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 1151,
"createdBy": "project:chromium",
"createTime": "2022-03-05T02:52:48.049327549Z",
"startTime": "2022-03-05T04:06:31.117827Z",
"endTime": "2022-03-05T13:28:14.550031850Z",
"updateTime": "2022-03-05T13:28:14.550031850Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4a2049c2c5edb1e9026b5707a7e22a87a6bbd73d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:28:15.081] Invocation finished in 10h35m28.472400401s with status SUCCEEDED