[16:33:06.166] New invocation is queued and will start shortly
[16:33:07.234] Starting the invocation (attempt 1)
[16:33:07.270] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a39c122c8f1d5d1baecf881b282fe0283b08cded"
[16:33:07.270] Popped gitiles commit info from properties and tags
[16:33:07.270] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:33:07.270] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:33:07.270] Buildbucket request:
{
"requestId": "9002524749131581184",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a39c122c8f1d5d1baecf881b282fe0283b08cded",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9002524749131581184"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:33:08.132] Scheduled build:
{
"id": "8837094687236520065",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"number": 350,
"createdBy": "project:chromium",
"createTime": "2021-09-03T16:33:07.340459770Z",
"updateTime": "2021-09-03T16:33:07.848655483Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a39c122c8f1d5d1baecf881b282fe0283b08cded",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:33:08.132] Task URL: https://cr-buildbucket.appspot.com/build/8837094687236520065
[16:33:08.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:2:0) after 9m9s
[16:42:17.290] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:2:0)
[16:42:17.331] Build status: SCHEDULED
[16:42:17.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:3:0) after 2m56s
[16:45:13.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:3:0)
[16:45:13.511] Build status: SCHEDULED
[16:45:13.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:4:0) after 6m29s
[16:50:40.840] Received PubSub notification, asking Buildbucket for the build status
[16:50:40.871] Build status: STARTED
[16:51:42.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:4:0)
[16:51:42.580] Build status: STARTED
[16:51:42.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:6:0) after 3m43s
[16:55:25.695] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:6:0)
[16:55:25.726] Build status: STARTED
[16:55:25.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:7:0) after 2m11s
[16:57:36.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:7:0)
[16:57:36.814] Build status: STARTED
[16:57:36.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:8:0) after 4m11s
[17:01:47.905] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:8:0)
[17:01:47.940] Build status: STARTED
[17:01:47.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:9:0) after 4m14s
[17:06:01.979] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:9:0)
[17:06:02.017] Build status: STARTED
[17:06:02.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:10:0) after 8m34s
[17:14:36.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:10:0)
[17:14:36.292] Build status: STARTED
[17:14:36.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:11:0) after 6m27s
[17:21:03.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:11:0)
[17:21:03.405] Build status: STARTED
[17:21:03.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:12:0) after 7m41s
[17:28:44.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:12:0)
[17:28:44.461] Build status: STARTED
[17:28:44.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:13:0) after 8m48s
[17:37:32.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:13:0)
[17:37:32.510] Build status: STARTED
[17:37:32.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:14:0) after 8m9s
[17:45:41.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:14:0)
[17:45:41.634] Build status: STARTED
[17:45:41.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:15:0) after 8m50s
[17:54:31.732] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:15:0)
[17:54:31.772] Build status: STARTED
[17:54:31.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:16:0) after 3m28s
[17:57:59.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:16:0)
[17:57:59.848] Build status: STARTED
[17:57:59.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:17:0) after 9m28s
[18:07:28.139] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:17:0)
[18:07:28.179] Build status: STARTED
[18:07:28.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:18:0) after 1m54s
[18:09:22.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:18:0)
[18:09:22.401] Build status: STARTED
[18:09:22.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:19:0) after 4m39s
[18:14:01.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:19:0)
[18:14:01.580] Build status: STARTED
[18:14:01.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:20:0) after 2m7s
[18:16:08.604] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:20:0)
[18:16:08.636] Build status: STARTED
[18:16:08.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:21:0) after 7m49s
[18:23:57.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:21:0)
[18:23:57.700] Build status: STARTED
[18:23:57.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:22:0) after 2m7s
[18:26:04.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:22:0)
[18:26:04.799] Build status: STARTED
[18:26:04.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:23:0) after 4m52s
[18:30:56.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:23:0)
[18:30:56.860] Build status: STARTED
[18:30:56.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:24:0) after 8m0s
[18:38:56.849] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:24:0)
[18:38:57.031] Build status: STARTED
[18:38:57.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:25:0) after 2m29s
[18:41:26.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:25:0)
[18:41:26.141] Build status: STARTED
[18:41:26.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:26:0) after 6m54s
[18:48:20.172] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:26:0)
[18:48:20.216] Build status: STARTED
[18:48:20.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:27:0) after 3m53s
[18:52:13.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:27:0)
[18:52:13.495] Build status: STARTED
[18:52:13.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:28:0) after 6m17s
[18:58:30.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:28:0)
[18:58:30.652] Build status: STARTED
[18:58:30.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:29:0) after 2m46s
[19:01:16.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:29:0)
[19:01:16.714] Build status: STARTED
[19:01:16.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:30:0) after 4m6s
[19:05:22.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:30:0)
[19:05:22.761] Build status: STARTED
[19:05:22.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:31:0) after 9m10s
[19:14:33.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:31:0)
[19:14:33.124] Build status: STARTED
[19:14:33.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:32:0) after 3m42s
[19:18:15.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:32:0)
[19:18:15.390] Build status: STARTED
[19:18:15.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:33:0) after 3m19s
[19:21:34.416] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:33:0)
[19:21:34.447] Build status: STARTED
[19:21:34.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:34:0) after 4m44s
[19:26:18.666] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:34:0)
[19:26:18.702] Build status: STARTED
[19:26:18.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:35:0) after 5m31s
[19:31:49.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:35:0)
[19:31:49.868] Build status: STARTED
[19:31:49.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:36:0) after 9m47s
[19:41:36.856] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:36:0)
[19:41:36.884] Build status: STARTED
[19:41:36.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:37:0) after 6m2s
[19:47:38.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:37:0)
[19:47:38.941] Build status: STARTED
[19:47:38.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:38:0) after 5m24s
[19:53:03.105] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:38:0)
[19:53:03.139] Build status: STARTED
[19:53:03.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:39:0) after 7m6s
[20:00:09.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:39:0)
[20:00:09.202] Build status: STARTED
[20:00:09.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:40:0) after 1m21s
[20:01:30.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:40:0)
[20:01:30.425] Build status: STARTED
[20:01:30.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:41:0) after 5m41s
[20:07:11.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:41:0)
[20:07:11.506] Build status: STARTED
[20:07:11.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:42:0) after 3m41s
[20:10:52.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:42:0)
[20:10:52.613] Build status: STARTED
[20:10:52.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:43:0) after 1m28s
[20:12:21.139] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:43:0)
[20:12:21.193] Build status: STARTED
[20:12:21.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:44:0) after 6m36s
[20:18:57.645] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:44:0)
[20:18:57.691] Build status: STARTED
[20:18:57.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:45:0) after 4m54s
[20:23:51.714] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:45:0)
[20:23:51.772] Build status: STARTED
[20:23:51.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:46:0) after 6m42s
[20:30:34.185] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:46:0)
[20:30:34.222] Build status: STARTED
[20:30:34.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:47:0) after 4m28s
[20:35:02.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:47:0)
[20:35:02.459] Build status: STARTED
[20:35:02.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:48:0) after 4m27s
[20:39:29.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:48:0)
[20:39:29.769] Build status: STARTED
[20:39:29.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:49:0) after 7m2s
[20:46:32.035] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:49:0)
[20:46:32.065] Build status: STARTED
[20:46:32.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:50:0) after 4m17s
[20:50:49.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:50:0)
[20:50:49.118] Build status: STARTED
[20:50:49.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:51:0) after 3m23s
[20:54:12.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:51:0)
[20:54:12.358] Build status: STARTED
[20:54:12.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:52:0) after 9m32s
[21:03:44.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:52:0)
[21:03:44.613] Build status: STARTED
[21:03:44.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:53:0) after 4m49s
[21:08:33.637] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:53:0)
[21:08:33.670] Build status: STARTED
[21:08:33.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:54:0) after 4m5s
[21:12:39.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:54:0)
[21:12:39.597] Build status: STARTED
[21:12:39.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:55:0) after 7m46s
[21:20:25.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:55:0)
[21:20:25.726] Build status: STARTED
[21:20:25.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:56:0) after 6m24s
[21:26:49.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:56:0)
[21:26:49.845] Build status: STARTED
[21:26:49.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:57:0) after 6m4s
[21:32:53.870] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:57:0)
[21:32:53.903] Build status: STARTED
[21:32:53.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:58:0) after 4m40s
[21:37:34.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:58:0)
[21:37:34.065] Build status: STARTED
[21:37:34.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:59:0) after 9m26s
[21:47:00.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:59:0)
[21:47:00.265] Build status: STARTED
[21:47:00.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:60:0) after 7m58s
[21:54:58.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:60:0)
[21:54:58.461] Build status: STARTED
[21:54:58.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:61:0) after 5m3s
[22:00:01.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:61:0)
[22:00:01.626] Build status: STARTED
[22:00:01.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:62:0) after 5m51s
[22:05:52.807] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:62:0)
[22:05:52.978] Build status: STARTED
[22:05:52.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:63:0) after 9m4s
[22:14:57.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:63:0)
[22:14:57.034] Build status: STARTED
[22:14:57.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:64:0) after 7m21s
[22:22:18.203] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:64:0)
[22:22:18.243] Build status: STARTED
[22:22:18.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:65:0) after 8m49s
[22:31:07.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:65:0)
[22:31:07.375] Build status: STARTED
[22:31:07.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:66:0) after 1m36s
[22:32:43.367] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:66:0)
[22:32:43.400] Build status: STARTED
[22:32:43.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:67:0) after 9m22s
[22:42:05.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:67:0)
[22:42:05.477] Build status: STARTED
[22:42:05.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:68:0) after 9m22s
[22:51:27.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:68:0)
[22:51:27.535] Build status: STARTED
[22:51:27.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:69:0) after 1m40s
[22:53:07.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:69:0)
[22:53:07.613] Build status: STARTED
[22:53:07.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:70:0) after 5m15s
[22:58:22.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:70:0)
[22:58:22.808] Build status: STARTED
[22:58:22.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:71:0) after 1m50s
[23:00:12.833] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:71:0)
[23:00:12.873] Build status: STARTED
[23:00:12.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:72:0) after 5m52s
[23:06:04.911] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:72:0)
[23:06:04.958] Build status: STARTED
[23:06:04.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:73:0) after 6m1s
[23:12:06.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:73:0)
[23:12:06.107] Build status: STARTED
[23:12:06.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:74:0) after 9m12s
[23:21:18.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:74:0)
[23:21:18.771] Build status: STARTED
[23:21:18.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:75:0) after 2m35s
[23:23:53.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:75:0)
[23:23:53.844] Build status: STARTED
[23:23:53.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:76:0) after 7m13s
[23:31:06.874] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:76:0)
[23:31:06.908] Build status: STARTED
[23:31:06.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:77:0) after 2m59s
[23:34:06.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:77:0)
[23:34:06.201] Build status: STARTED
[23:34:06.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:78:0) after 9m14s
[23:43:20.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:78:0)
[23:43:20.259] Build status: STARTED
[23:43:20.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:79:0) after 8m26s
[23:51:46.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:79:0)
[23:51:46.404] Build status: STARTED
[23:51:46.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:80:0) after 3m18s
[23:55:04.414] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:80:0)
[23:55:04.445] Build status: STARTED
[23:55:04.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:81:0) after 7m46s
[00:02:50.472] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:81:0)
[00:02:50.507] Build status: STARTED
[00:02:50.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:82:0) after 2m39s
[00:05:29.567] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:82:0)
[00:05:29.596] Build status: STARTED
[00:05:29.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:83:0) after 1m58s
[00:07:27.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:83:0)
[00:07:27.652] Build status: STARTED
[00:07:27.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:84:0) after 4m8s
[00:11:35.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:84:0)
[00:11:35.699] Build status: STARTED
[00:11:35.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:85:0) after 8m58s
[00:20:33.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:85:0)
[00:20:33.840] Build status: STARTED
[00:20:33.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:86:0) after 4m57s
[00:25:30.959] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:86:0)
[00:25:31.088] Build status: STARTED
[00:25:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:87:0) after 8m34s
[00:34:05.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:87:0)
[00:34:05.273] Build status: STARTED
[00:34:05.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:88:0) after 7m44s
[00:41:49.347] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:88:0)
[00:41:49.385] Build status: STARTED
[00:41:49.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:89:0) after 5m15s
[00:47:04.533] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:89:0)
[00:47:04.572] Build status: STARTED
[00:47:04.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:90:0) after 3m35s
[00:50:39.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:90:0)
[00:50:39.626] Build status: STARTED
[00:50:39.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:91:0) after 1m14s
[00:51:53.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:91:0)
[00:51:53.690] Build status: STARTED
[00:51:53.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:92:0) after 3m24s
[00:55:17.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:92:0)
[00:55:17.905] Build status: STARTED
[00:55:17.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:93:0) after 6m31s
[01:01:49.160] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:93:0)
[01:01:49.208] Build status: STARTED
[01:01:49.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:94:0) after 4m48s
[01:06:37.389] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:94:0)
[01:06:37.417] Build status: STARTED
[01:06:37.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9002524749131581184:95:0) after 9m30s
[01:13:18.631] Received PubSub notification, asking Buildbucket for the build status
[01:13:18.668] Build:
{
"id": "8837094687236520065",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"number": 350,
"createdBy": "project:chromium",
"createTime": "2021-09-03T16:33:07.340459770Z",
"startTime": "2021-09-03T16:50:39.802336Z",
"endTime": "2021-09-04T01:13:18.299573999Z",
"updateTime": "2021-09-04T01:13:18.299992697Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a39c122c8f1d5d1baecf881b282fe0283b08cded",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:13:18.668] Invocation finished in 8h40m12.518779986s with status SUCCEEDED