[16:39:42.544] New invocation is queued and will start shortly
[16:39:43.760] Starting the invocation (attempt 1)
[16:39:43.800] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc6d983842a7798f4508ae5fb17627d1ecd5f684"
[16:39:43.800] Popped gitiles commit info from properties and tags
[16:39:43.800] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:39:43.801] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:39:43.801] Buildbucket request:
{
"requestId": "9001255975971111680",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bc6d983842a7798f4508ae5fb17627d1ecd5f684",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9001255975971111680"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dll)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:39:44.456] Scheduled build:
{
"id": "8835825913875493665",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9007,
"createdBy": "project:chromium",
"createTime": "2021-09-17T16:39:43.908981068Z",
"updateTime": "2021-09-17T16:39:44.193807294Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bc6d983842a7798f4508ae5fb17627d1ecd5f684",
"ref": "refs/heads/main"
}
}
}
[16:39:44.456] Task URL: https://cr-buildbucket.appspot.com/build/8835825913875493665
[16:39:44.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:2:0) after 2m33s
[16:42:17.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:2:0)
[16:42:17.693] Build status: SCHEDULED
[16:42:17.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:3:0) after 4m24s
[16:46:41.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:3:0)
[16:46:41.766] Build status: SCHEDULED
[16:46:41.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:4:0) after 4m17s
[16:50:58.785] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:4:0)
[16:50:58.810] Build status: SCHEDULED
[16:50:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:5:0) after 3m43s
[16:54:42.243] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:5:0)
[16:54:42.284] Build status: SCHEDULED
[16:54:42.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:6:0) after 4m57s
[16:59:39.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:6:0)
[16:59:39.342] Build status: SCHEDULED
[16:59:39.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:7:0) after 6m46s
[17:06:25.465] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:7:0)
[17:06:25.607] Build status: SCHEDULED
[17:06:25.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:8:0) after 5m41s
[17:12:06.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:8:0)
[17:12:06.685] Build status: SCHEDULED
[17:12:06.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:9:0) after 4m22s
[17:16:28.716] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:9:0)
[17:16:28.757] Build status: SCHEDULED
[17:16:28.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:10:0) after 4m5s
[17:20:33.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:10:0)
[17:20:34.073] Build status: SCHEDULED
[17:20:34.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:11:0) after 4m30s
[17:25:04.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:11:0)
[17:25:04.345] Build status: SCHEDULED
[17:25:04.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:12:0) after 6m28s
[17:31:32.472] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:12:0)
[17:31:32.520] Build status: SCHEDULED
[17:31:32.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:13:0) after 3m58s
[17:35:30.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:13:0)
[17:35:30.755] Build status: SCHEDULED
[17:35:30.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:14:0) after 3m37s
[17:39:07.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:14:0)
[17:39:07.909] Build status: SCHEDULED
[17:39:07.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:15:0) after 8m0s
[17:47:07.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:15:0)
[17:47:07.972] Build status: SCHEDULED
[17:47:07.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:16:0) after 9m59s
[17:57:07.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:16:0)
[17:57:07.027] Build status: SCHEDULED
[17:57:07.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:17:0) after 5m1s
[18:02:08.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:17:0)
[18:02:08.288] Build status: SCHEDULED
[18:02:08.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:18:0) after 3m24s
[18:05:32.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:18:0)
[18:05:32.346] Build status: SCHEDULED
[18:05:32.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:19:0) after 8m14s
[18:13:46.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:19:0)
[18:13:46.398] Build status: SCHEDULED
[18:13:46.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:20:0) after 2m1s
[18:15:47.471] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:20:0)
[18:15:47.512] Build status: SCHEDULED
[18:15:47.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:21:0) after 9m3s
[18:18:25.514] Received PubSub notification, asking Buildbucket for the build status
[18:18:25.669] Build status: STARTED
[18:24:50.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:21:0)
[18:24:50.557] Build status: STARTED
[18:24:50.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:23:0) after 5m0s
[18:29:50.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:23:0)
[18:29:50.823] Build status: STARTED
[18:29:50.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:24:0) after 5m45s
[18:35:36.130] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:24:0)
[18:35:36.160] Build status: STARTED
[18:35:36.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:25:0) after 2m46s
[18:38:22.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:25:0)
[18:38:22.293] Build status: STARTED
[18:38:22.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:26:0) after 2m49s
[18:41:11.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:26:0)
[18:41:11.470] Build status: STARTED
[18:41:11.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:27:0) after 1m15s
[18:42:26.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:27:0)
[18:42:26.568] Build status: STARTED
[18:42:26.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:28:0) after 6m46s
[18:49:12.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:28:0)
[18:49:12.995] Build status: STARTED
[18:49:12.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:29:0) after 4m52s
[18:54:05.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:29:0)
[18:54:05.066] Build status: STARTED
[18:54:05.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:30:0) after 1m18s
[18:55:23.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:30:0)
[18:55:23.319] Build status: STARTED
[18:55:23.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:31:0) after 3m23s
[18:58:46.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:31:0)
[18:58:46.474] Build status: STARTED
[18:58:46.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:32:0) after 1m12s
[18:59:58.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:32:0)
[18:59:58.539] Build status: STARTED
[18:59:58.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:33:0) after 1m47s
[19:01:45.568] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:33:0)
[19:01:45.599] Build status: STARTED
[19:01:45.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:34:0) after 3m32s
[19:05:17.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:34:0)
[19:05:17.810] Build status: STARTED
[19:05:17.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:35:0) after 3m48s
[19:09:05.973] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:35:0)
[19:09:06.069] Build status: STARTED
[19:09:06.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:36:0) after 9m59s
[19:19:05.351] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:36:0)
[19:19:05.777] Build status: STARTED
[19:19:05.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:37:0) after 8m43s
[19:27:49.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:37:0)
[19:27:49.055] Build status: STARTED
[19:27:49.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:38:0) after 5m26s
[19:33:15.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:38:0)
[19:33:15.335] Build status: STARTED
[19:33:15.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:39:0) after 7m25s
[19:40:40.369] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:39:0)
[19:40:40.403] Build status: STARTED
[19:40:40.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:40:0) after 2m29s
[19:43:09.391] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:40:0)
[19:43:09.426] Build status: STARTED
[19:43:09.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:41:0) after 9m9s
[19:52:18.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:41:0)
[19:52:18.571] Build status: STARTED
[19:52:18.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:42:0) after 6m56s
[19:59:14.637] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:42:0)
[19:59:14.679] Build status: STARTED
[19:59:14.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:43:0) after 7m41s
[20:06:55.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:43:0)
[20:06:55.991] Build status: STARTED
[20:06:55.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:44:0) after 4m35s
[20:11:31.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:44:0)
[20:11:31.484] Build status: STARTED
[20:11:31.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:45:0) after 8m11s
[20:19:42.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:45:0)
[20:19:42.642] Build status: STARTED
[20:19:42.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:46:0) after 6m40s
[20:26:22.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:46:0)
[20:26:22.704] Build status: STARTED
[20:26:22.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:47:0) after 8m43s
[20:35:05.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:47:0)
[20:35:05.778] Build status: STARTED
[20:35:05.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:48:0) after 4m26s
[20:39:31.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:48:0)
[20:39:31.936] Build status: STARTED
[20:39:31.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:49:0) after 6m22s
[20:45:54.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:49:0)
[20:45:54.045] Build status: STARTED
[20:45:54.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:50:0) after 7m44s
[20:53:38.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:50:0)
[20:53:38.101] Build status: STARTED
[20:53:38.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:51:0) after 6m38s
[21:00:16.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:51:0)
[21:00:16.420] Build status: STARTED
[21:00:16.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:52:0) after 5m33s
[21:05:49.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:52:0)
[21:05:49.611] Build status: STARTED
[21:05:49.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:53:0) after 9m44s
[21:15:33.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:53:0)
[21:15:33.772] Build status: STARTED
[21:15:33.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:54:0) after 8m33s
[21:24:06.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:54:0)
[21:24:06.924] Build status: STARTED
[21:24:06.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:55:0) after 7m32s
[21:31:38.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:55:0)
[21:31:38.984] Build status: STARTED
[21:31:38.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:56:0) after 5m22s
[21:37:01.019] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:56:0)
[21:37:01.060] Build status: STARTED
[21:37:01.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:57:0) after 5m32s
[21:42:33.084] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:57:0)
[21:42:33.707] Build status: STARTED
[21:42:33.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:58:0) after 9m56s
[21:52:29.751] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:58:0)
[21:52:29.785] Build status: STARTED
[21:52:29.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:59:0) after 3m0s
[21:55:29.944] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:59:0)
[21:55:29.975] Build status: STARTED
[21:55:29.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:60:0) after 8m37s
[22:04:07.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:60:0)
[22:04:07.059] Build status: STARTED
[22:04:07.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:61:0) after 5m29s
[22:09:36.136] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:61:0)
[22:09:36.173] Build status: STARTED
[22:09:36.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:62:0) after 1m57s
[22:11:33.313] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:62:0)
[22:11:33.359] Build status: STARTED
[22:11:33.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:63:0) after 2m17s
[22:13:50.399] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:63:0)
[22:13:50.427] Build status: STARTED
[22:13:50.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:64:0) after 2m21s
[22:16:11.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:64:0)
[22:16:11.478] Build status: STARTED
[22:16:11.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:65:0) after 1m11s
[22:17:22.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:65:0)
[22:17:22.649] Build status: STARTED
[22:17:22.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:66:0) after 1m45s
[22:19:07.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:66:0)
[22:19:07.742] Build status: STARTED
[22:19:07.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:67:0) after 3m7s
[22:22:14.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:67:0)
[22:22:14.800] Build status: STARTED
[22:22:14.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:68:0) after 9m19s
[22:31:34.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:68:0)
[22:31:34.087] Build status: STARTED
[22:31:34.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:69:0) after 4m14s
[22:35:48.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:69:0)
[22:35:48.279] Build status: STARTED
[22:35:48.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:70:0) after 4m17s
[22:40:05.463] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:70:0)
[22:40:05.610] Build status: STARTED
[22:40:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:71:0) after 3m1s
[22:43:07.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:71:0)
[22:43:07.255] Build status: STARTED
[22:43:07.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:72:0) after 1m26s
[22:44:33.412] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:72:0)
[22:44:33.440] Build status: STARTED
[22:44:33.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:73:0) after 9m16s
[22:53:49.573] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:73:0)
[22:53:49.626] Build status: STARTED
[22:53:49.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:74:0) after 3m20s
[22:57:09.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:74:0)
[22:57:09.809] Build status: STARTED
[22:57:09.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:75:0) after 4m20s
[23:01:29.873] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:75:0)
[23:01:29.907] Build status: STARTED
[23:01:29.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:76:0) after 7m54s
[23:09:24.017] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:76:0)
[23:09:24.055] Build status: STARTED
[23:09:24.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:77:0) after 2m52s
[23:12:16.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:77:0)
[23:12:16.126] Build status: STARTED
[23:12:16.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:78:0) after 6m20s
[23:18:36.121] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:78:0)
[23:18:36.264] Build status: STARTED
[23:18:36.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:79:0) after 1m12s
[23:19:48.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:79:0)
[23:19:48.411] Build status: STARTED
[23:19:48.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:80:0) after 2m7s
[23:21:55.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:80:0)
[23:21:55.585] Build status: STARTED
[23:21:55.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:81:0) after 8m17s
[23:30:12.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:81:0)
[23:30:12.637] Build status: STARTED
[23:30:12.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:82:0) after 3m12s
[23:33:24.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:82:0)
[23:33:24.827] Build status: STARTED
[23:33:24.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:83:0) after 5m17s
[23:38:41.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:83:0)
[23:38:41.960] Build status: STARTED
[23:38:41.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:84:0) after 7m14s
[23:45:56.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:84:0)
[23:45:56.146] Build status: STARTED
[23:45:56.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:85:0) after 7m56s
[23:53:52.190] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:85:0)
[23:53:52.221] Build status: STARTED
[23:53:52.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:86:0) after 9m50s
[00:03:42.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:86:0)
[00:03:42.312] Build status: STARTED
[00:03:42.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:87:0) after 4m14s
[00:07:56.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:87:0)
[00:07:56.644] Build status: STARTED
[00:07:56.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:88:0) after 2m59s
[00:10:55.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:88:0)
[00:10:55.684] Build status: STARTED
[00:10:55.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:89:0) after 4m45s
[00:15:40.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:89:0)
[00:15:40.787] Build status: STARTED
[00:15:40.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:90:0) after 1m43s
[00:17:23.816] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:90:0)
[00:17:23.845] Build status: STARTED
[00:17:23.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:91:0) after 2m26s
[00:19:49.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:91:0)
[00:19:49.955] Build status: STARTED
[00:19:49.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:92:0) after 1m28s
[00:21:18.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:92:0)
[00:21:18.143] Build status: STARTED
[00:21:18.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:93:0) after 1m48s
[00:23:06.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:93:0)
[00:23:06.421] Build status: STARTED
[00:23:06.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:94:0) after 6m20s
[00:29:26.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:94:0)
[00:29:26.487] Build status: STARTED
[00:29:26.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:95:0) after 7m9s
[00:36:35.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:95:0)
[00:36:35.561] Build status: STARTED
[00:36:35.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:96:0) after 1m38s
[00:38:13.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:96:0)
[00:38:13.689] Build status: STARTED
[00:38:13.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:97:0) after 1m59s
[00:40:12.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:97:0)
[00:40:12.761] Build status: STARTED
[00:40:12.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:98:0) after 4m50s
[00:45:02.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:98:0)
[00:45:03.066] Build status: STARTED
[00:45:03.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:99:0) after 6m34s
[00:51:37.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:99:0)
[00:51:37.137] Build status: STARTED
[00:51:37.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:100:0) after 8m42s
[01:00:19.407] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:100:0)
[01:00:19.448] Build status: STARTED
[01:00:19.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:101:0) after 6m50s
[01:07:09.751] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:101:0)
[01:07:09.781] Build status: STARTED
[01:07:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:102:0) after 5m15s
[01:12:25.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:102:0)
[01:12:25.282] Build status: STARTED
[01:12:25.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:103:0) after 3m42s
[01:16:07.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:103:0)
[01:16:07.406] Build status: STARTED
[01:16:07.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:104:0) after 1m18s
[01:17:25.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:104:0)
[01:17:25.489] Build status: STARTED
[01:17:25.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:105:0) after 3m14s
[01:20:39.528] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:105:0)
[01:20:39.557] Build status: STARTED
[01:20:39.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:106:0) after 6m59s
[01:27:38.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:106:0)
[01:27:38.820] Build status: STARTED
[01:27:38.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:107:0) after 7m58s
[01:35:36.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:107:0)
[01:35:37.034] Build status: STARTED
[01:35:37.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:108:0) after 9m44s
[01:45:21.068] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:108:0)
[01:45:21.102] Build status: STARTED
[01:45:21.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:109:0) after 9m18s
[01:54:39.199] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:109:0)
[01:54:39.254] Build status: STARTED
[01:54:39.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:110:0) after 8m33s
[02:03:12.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:110:0)
[02:03:12.417] Build status: STARTED
[02:03:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:111:0) after 3m50s
[02:07:02.446] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:111:0)
[02:07:02.515] Build status: STARTED
[02:07:02.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:112:0) after 8m41s
[02:15:43.747] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:112:0)
[02:15:43.785] Build status: STARTED
[02:15:43.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:113:0) after 9m11s
[02:24:54.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:113:0)
[02:24:54.844] Build status: STARTED
[02:24:54.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:114:0) after 5m31s
[02:30:25.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:114:0)
[02:30:25.911] Build status: STARTED
[02:30:25.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:115:0) after 5m42s
[02:36:08.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:115:0)
[02:36:08.078] Build status: STARTED
[02:36:08.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:116:0) after 1m16s
[02:37:24.283] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:116:0)
[02:37:24.327] Build status: STARTED
[02:37:24.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:117:0) after 5m19s
[02:42:43.596] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:117:0)
[02:42:43.631] Build status: STARTED
[02:42:43.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):9001255975971111680:118:0) after 7m1s
[02:47:51.006] Received PubSub notification, asking Buildbucket for the build status
[02:47:51.037] Build:
{
"id": "8835825913875493665",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9007,
"createdBy": "project:chromium",
"createTime": "2021-09-17T16:39:43.908981068Z",
"startTime": "2021-09-17T18:18:24.852682Z",
"endTime": "2021-09-18T02:47:50.693590036Z",
"updateTime": "2021-09-18T02:47:50.694136606Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bc6d983842a7798f4508ae5fb17627d1ecd5f684",
"ref": "refs/heads/main"
}
}
}
[02:47:51.037] Invocation finished in 10h8m8.511263942s with status FAILED