[10:46:28.058] New invocation is queued and will start shortly
[10:46:29.130] Starting the invocation (attempt 1)
[10:46:29.168] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9c2ed0664fb127fba0b3cd248606fafeee8f36ec"
[10:46:29.168] Popped gitiles commit info from properties and tags
[10:46:29.168] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:46:29.168] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:46:29.168] Buildbucket request:
{
"requestId": "8998560291004546912",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c2ed0664fb127fba0b3cd248606fafeee8f36ec",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8998560291004546912"
},
{
"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"
}
}
[10:46:29.642] Scheduled build:
{
"id": "8833130229105967201",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9163,
"createdBy": "project:chromium",
"createTime": "2021-10-17T10:46:29.237227428Z",
"updateTime": "2021-10-17T10:46:29.467206947Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c2ed0664fb127fba0b3cd248606fafeee8f36ec",
"ref": "refs/heads/main"
}
}
}
[10:46:29.642] Task URL: https://cr-buildbucket.appspot.com/build/8833130229105967201
[10:46:29.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:2:0) after 3m18s
[10:49:47.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:2:0)
[10:49:47.767] Build status: SCHEDULED
[10:49:47.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:3:0) after 6m12s
[10:55:59.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:3:0)
[10:55:59.817] Build status: SCHEDULED
[10:55:59.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:4:0) after 6m32s
[11:02:31.958] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:4:0)
[11:02:31.985] Build status: SCHEDULED
[11:02:31.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:5:0) after 5m40s
[11:08:12.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:5:0)
[11:08:12.072] Build status: SCHEDULED
[11:08:12.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:6:0) after 3m24s
[11:11:36.374] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:6:0)
[11:11:36.403] Build status: SCHEDULED
[11:11:36.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:7:0) after 2m58s
[11:14:34.620] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:7:0)
[11:14:34.648] Build status: SCHEDULED
[11:14:34.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:8:0) after 3m49s
[11:18:23.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:8:0)
[11:18:23.744] Build status: SCHEDULED
[11:18:23.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:9:0) after 6m32s
[11:24:55.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:9:0)
[11:24:55.854] Build status: SCHEDULED
[11:24:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:10:0) after 9m16s
[11:34:11.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:10:0)
[11:34:11.899] Build status: SCHEDULED
[11:34:11.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:11:0) after 9m58s
[11:44:09.920] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:11:0)
[11:44:09.986] Build status: SCHEDULED
[11:44:09.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:12:0) after 2m16s
[11:46:26.148] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:12:0)
[11:46:26.181] Build status: SCHEDULED
[11:46:26.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:13:0) after 4m48s
[11:51:14.197] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:13:0)
[11:51:14.232] Build status: SCHEDULED
[11:51:14.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:14:0) after 9m15s
[11:52:31.219] Received PubSub notification, asking Buildbucket for the build status
[11:52:31.250] Build status: STARTED
[12:00:29.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:14:0)
[12:00:29.278] Build status: STARTED
[12:00:29.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:16:0) after 2m1s
[12:02:30.666] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:16:0)
[12:02:30.763] Build status: STARTED
[12:02:30.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:17:0) after 8m35s
[12:11:05.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:17:0)
[12:11:05.831] Build status: STARTED
[12:11:05.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:18:0) after 8m8s
[12:19:13.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:18:0)
[12:19:13.892] Build status: STARTED
[12:19:13.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:19:0) after 2m1s
[12:21:14.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:19:0)
[12:21:14.951] Build status: STARTED
[12:21:14.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:20:0) after 6m56s
[12:28:11.120] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:20:0)
[12:28:11.155] Build status: STARTED
[12:28:11.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:21:0) after 8m25s
[12:36:36.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:21:0)
[12:36:36.500] Build status: STARTED
[12:36:36.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:22:0) after 1m6s
[12:37:42.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:22:0)
[12:37:42.859] Build status: STARTED
[12:37:42.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:23:0) after 1m18s
[12:39:01.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:23:0)
[12:39:01.058] Build status: STARTED
[12:39:01.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:24:0) after 1m4s
[12:40:05.090] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:24:0)
[12:40:05.127] Build status: STARTED
[12:40:05.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:25:0) after 3m46s
[12:43:51.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:25:0)
[12:43:51.832] Build status: STARTED
[12:43:51.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:26:0) after 1m12s
[12:45:03.873] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:26:0)
[12:45:03.944] Build status: STARTED
[12:45:03.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:27:0) after 6m11s
[12:51:14.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:27:0)
[12:51:14.994] Build status: STARTED
[12:51:14.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:28:0) after 6m35s
[12:57:50.127] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:28:0)
[12:57:50.186] Build status: STARTED
[12:57:50.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:29:0) after 5m11s
[13:03:01.419] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:29:0)
[13:03:01.514] Build status: STARTED
[13:03:01.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:30:0) after 1m20s
[13:04:21.535] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:30:0)
[13:04:21.571] Build status: STARTED
[13:04:21.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:31:0) after 4m39s
[13:09:00.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:31:0)
[13:09:00.770] Build status: STARTED
[13:09:00.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:32:0) after 8m55s
[13:17:56.040] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:32:0)
[13:17:56.068] Build status: STARTED
[13:17:56.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:33:0) after 6m55s
[13:24:51.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:33:0)
[13:24:51.549] Build status: STARTED
[13:24:51.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:34:0) after 5m58s
[13:30:49.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:34:0)
[13:30:49.782] Build status: STARTED
[13:30:49.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:35:0) after 6m57s
[13:37:46.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:35:0)
[13:37:46.836] Build status: STARTED
[13:37:46.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:36:0) after 4m23s
[13:42:10.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:36:0)
[13:42:10.071] Build status: STARTED
[13:42:10.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:37:0) after 3m30s
[13:45:40.105] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:37:0)
[13:45:40.140] Build status: STARTED
[13:45:40.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:38:0) after 4m25s
[13:50:05.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:38:0)
[13:50:05.280] Build status: STARTED
[13:50:05.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:39:0) after 2m9s
[13:52:14.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:39:0)
[13:52:14.340] Build status: STARTED
[13:52:14.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:40:0) after 3m35s
[13:55:49.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:40:0)
[13:55:49.394] Build status: STARTED
[13:55:49.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:41:0) after 7m17s
[14:03:06.580] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:41:0)
[14:03:06.611] Build status: STARTED
[14:03:06.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:42:0) after 2m18s
[14:05:24.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:42:0)
[14:05:24.739] Build status: STARTED
[14:05:24.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:43:0) after 5m41s
[14:11:05.764] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:43:0)
[14:11:05.804] Build status: STARTED
[14:11:05.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:44:0) after 3m48s
[14:14:53.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:44:0)
[14:14:53.858] Build status: STARTED
[14:14:53.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:45:0) after 8m11s
[14:23:04.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:45:0)
[14:23:05.074] Build status: STARTED
[14:23:05.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:46:0) after 8m37s
[14:31:42.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:46:0)
[14:31:42.126] Build status: STARTED
[14:31:42.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:47:0) after 7m9s
[14:38:51.148] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:47:0)
[14:38:51.200] Build status: STARTED
[14:38:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:48:0) after 8m5s
[14:46:56.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:48:0)
[14:46:56.249] Build status: STARTED
[14:46:56.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:49:0) after 8m21s
[14:55:17.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:49:0)
[14:55:17.522] Build status: STARTED
[14:55:17.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:50:0) after 2m35s
[14:57:52.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:50:0)
[14:57:52.693] Build status: STARTED
[14:57:52.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:51:0) after 3m38s
[15:01:30.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:51:0)
[15:01:30.749] Build status: STARTED
[15:01:30.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:52:0) after 9m31s
[15:11:01.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:52:0)
[15:11:01.855] Build status: STARTED
[15:11:01.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:53:0) after 7m13s
[15:18:14.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:53:0)
[15:18:14.913] Build status: STARTED
[15:18:14.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:54:0) after 8m30s
[15:26:44.903] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:54:0)
[15:26:44.942] Build status: STARTED
[15:26:44.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:55:0) after 4m14s
[15:30:59.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:55:0)
[15:30:59.079] Build status: STARTED
[15:30:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:56:0) after 3m42s
[15:34:41.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:56:0)
[15:34:41.735] Build status: STARTED
[15:34:41.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:57:0) after 2m12s
[15:36:54.077] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:57:0)
[15:36:54.115] Build status: STARTED
[15:36:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:58:0) after 8m18s
[15:45:12.138] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:58:0)
[15:45:12.170] Build status: STARTED
[15:45:12.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:59:0) after 9m36s
[15:54:48.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:59:0)
[15:54:48.332] Build status: STARTED
[15:54:48.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:60:0) after 6m48s
[16:01:36.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:60:0)
[16:01:36.409] Build status: STARTED
[16:01:36.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:61:0) after 9m29s
[16:11:05.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:61:0)
[16:11:05.484] Build status: STARTED
[16:11:05.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:62:0) after 6m42s
[16:17:47.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:62:0)
[16:17:47.624] Build status: STARTED
[16:17:47.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:63:0) after 4m31s
[16:22:18.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:63:0)
[16:22:18.889] Build status: STARTED
[16:22:18.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:64:0) after 8m0s
[16:30:18.911] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:64:0)
[16:30:18.938] Build status: STARTED
[16:30:18.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:65:0) after 7m20s
[16:37:39.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:65:0)
[16:37:39.330] Build status: STARTED
[16:37:39.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:66:0) after 4m14s
[16:41:53.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:66:0)
[16:41:53.690] Build status: STARTED
[16:41:53.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:67:0) after 3m4s
[16:44:58.212] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:67:0)
[16:44:58.245] Build status: STARTED
[16:44:58.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:68:0) after 6m13s
[16:51:11.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:68:0)
[16:51:11.294] Build status: STARTED
[16:51:11.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:69:0) after 2m15s
[16:53:26.477] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:69:0)
[16:53:26.513] Build status: STARTED
[16:53:26.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:70:0) after 1m43s
[16:55:09.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:70:0)
[16:55:09.522] Build status: STARTED
[16:55:09.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:71:0) after 6m35s
[17:01:44.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:71:0)
[17:01:44.728] Build status: STARTED
[17:01:44.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:72:0) after 1m48s
[17:03:32.755] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:72:0)
[17:03:32.790] Build status: STARTED
[17:03:32.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:73:0) after 8m28s
[17:12:00.873] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:73:0)
[17:12:00.905] Build status: STARTED
[17:12:00.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:74:0) after 6m42s
[17:18:42.971] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:74:0)
[17:18:43.066] Build status: STARTED
[17:18:43.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:75:0) after 2m46s
[17:21:29.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:75:0)
[17:21:29.128] Build status: STARTED
[17:21:29.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:76:0) after 6m23s
[17:27:52.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:76:0)
[17:27:52.200] Build status: STARTED
[17:27:52.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:77:0) after 2m31s
[17:30:23.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:77:0)
[17:30:23.340] Build status: STARTED
[17:30:23.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:78:0) after 3m20s
[17:33:43.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:78:0)
[17:33:43.399] Build status: STARTED
[17:33:43.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:79:0) after 6m18s
[17:40:01.564] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:79:0)
[17:40:01.600] Build status: STARTED
[17:40:01.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:80:0) after 5m0s
[17:45:02.178] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:80:0)
[17:45:02.232] Build status: STARTED
[17:45:02.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:81:0) after 8m9s
[17:53:11.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:81:0)
[17:53:11.281] Build status: STARTED
[17:53:11.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:82:0) after 4m14s
[17:57:25.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:82:0)
[17:57:25.343] Build status: STARTED
[17:57:25.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:83:0) after 8m52s
[18:06:17.458] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:83:0)
[18:06:17.592] Build status: STARTED
[18:06:17.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:84:0) after 8m41s
[18:14:59.400] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:84:0)
[18:14:59.426] Build status: STARTED
[18:14:59.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:85:0) after 4m47s
[18:19:46.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:85:0)
[18:19:46.528] Build status: STARTED
[18:19:46.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:86:0) after 4m23s
[18:24:09.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:86:0)
[18:24:09.893] Build status: STARTED
[18:24:09.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:87:0) after 2m36s
[18:26:46.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:87:0)
[18:26:46.364] Build status: STARTED
[18:26:46.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:88:0) after 9m5s
[18:35:51.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:88:0)
[18:35:51.518] Build status: STARTED
[18:35:51.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:89:0) after 8m53s
[18:44:44.560] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:89:0)
[18:44:44.591] Build status: STARTED
[18:44:44.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:90:0) after 1m5s
[18:45:49.703] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:90:0)
[18:45:49.729] Build status: STARTED
[18:45:49.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:91:0) after 1m40s
[18:47:29.850] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:91:0)
[18:47:29.907] Build status: STARTED
[18:47:29.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:92:0) after 9m55s
[18:57:25.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:92:0)
[18:57:25.282] Build status: STARTED
[18:57:25.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:93:0) after 7m13s
[19:04:38.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:93:0)
[19:04:38.948] Build status: STARTED
[19:04:38.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:94:0) after 8m33s
[19:13:11.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:94:0)
[19:13:12.014] Build status: STARTED
[19:13:12.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:95:0) after 1m55s
[19:15:07.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:95:0)
[19:15:07.052] Build status: STARTED
[19:15:07.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:96:0) after 8m45s
[19:23:52.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:96:0)
[19:23:52.146] Build status: STARTED
[19:23:52.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:97:0) after 9m21s
[19:33:14.035] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:97:0)
[19:33:14.142] Build status: STARTED
[19:33:14.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:98:0) after 4m4s
[19:37:18.374] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:98:0)
[19:37:18.403] Build status: STARTED
[19:37:18.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:99:0) after 5m46s
[19:43:04.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:99:0)
[19:43:04.741] Build status: STARTED
[19:43:04.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:100:0) after 5m49s
[19:48:53.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:100:0)
[19:48:54.056] Build status: STARTED
[19:48:54.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:101:0) after 3m35s
[19:52:29.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:101:0)
[19:52:29.225] Build status: STARTED
[19:52:29.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:102:0) after 5m27s
[19:57:56.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:102:0)
[19:57:56.368] Build status: STARTED
[19:57:56.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:103:0) after 1m3s
[19:58:59.526] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:103:0)
[19:58:59.664] Build status: STARTED
[19:58:59.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:104:0) after 4m55s
[20:03:54.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:104:0)
[20:03:54.877] Build status: STARTED
[20:03:54.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:105:0) after 3m59s
[20:07:53.903] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:105:0)
[20:07:53.946] Build status: STARTED
[20:07:53.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:106:0) after 7m30s
[20:15:23.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:106:0)
[20:15:24.002] Build status: STARTED
[20:15:24.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:107:0) after 1m45s
[20:17:09.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:107:0)
[20:17:09.077] Build status: STARTED
[20:17:09.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:108:0) after 3m9s
[20:20:18.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:108:0)
[20:20:18.207] Build status: STARTED
[20:20:18.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:109:0) after 7m48s
[20:28:06.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:109:0)
[20:28:06.362] Build status: STARTED
[20:28:06.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8998560291004546912:110:0) after 6m27s
[20:33:49.517] Received PubSub notification, asking Buildbucket for the build status
[20:33:49.546] Build:
{
"id": "8833130229105967201",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9163,
"createdBy": "project:chromium",
"createTime": "2021-10-17T10:46:29.237227428Z",
"startTime": "2021-10-17T11:52:30.385357Z",
"endTime": "2021-10-17T20:33:38.152218724Z",
"updateTime": "2021-10-17T20:33:38.152910888Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c2ed0664fb127fba0b3cd248606fafeee8f36ec",
"ref": "refs/heads/main"
}
}
}
[20:33:49.546] Invocation finished in 9h47m21.50347328s with status FAILED