[17:20:12.563] New invocation is queued and will start shortly
[17:20:15.082] Starting the invocation (attempt 1)
[17:20:15.119] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8fa0ef429b1f3f47bd3877e6c610acff006bdd7c"
[17:20:15.119] Popped gitiles commit info from properties and tags
[17:20:15.119] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:20:15.119] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:20:15.119] Buildbucket request:
{
"requestId": "8992465522167918208",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fa0ef429b1f3f47bd3877e6c610acff006bdd7c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8992465522167918208"
},
{
"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"
}
}
[17:20:15.681] Scheduled build:
{
"id": "8827035458749129521",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9482,
"createdBy": "project:chromium",
"createTime": "2021-12-23T17:20:15.191665883Z",
"updateTime": "2021-12-23T17:20:15.191665883Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fa0ef429b1f3f47bd3877e6c610acff006bdd7c",
"ref": "refs/heads/main"
}
}
}
[17:20:15.681] Task URL: https://cr-buildbucket.appspot.com/build/8827035458749129521
[17:20:15.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:2:0) after 7m28s
[17:27:43.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:2:0)
[17:27:43.718] Build status: SCHEDULED
[17:27:43.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:3:0) after 9m4s
[17:36:47.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:3:0)
[17:36:47.808] Build status: SCHEDULED
[17:36:47.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:4:0) after 5m45s
[17:42:32.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:4:0)
[17:42:32.959] Build status: SCHEDULED
[17:42:32.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:5:0) after 9m58s
[17:52:30.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:5:0)
[17:52:31.001] Build status: SCHEDULED
[17:52:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:6:0) after 5m24s
[17:57:55.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:6:0)
[17:57:55.336] Build status: SCHEDULED
[17:57:55.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:7:0) after 4m30s
[18:02:25.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:7:0)
[18:02:25.396] Build status: SCHEDULED
[18:02:25.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:8:0) after 8m0s
[18:10:25.425] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:8:0)
[18:10:25.449] Build status: SCHEDULED
[18:10:25.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:9:0) after 2m1s
[18:12:26.493] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:9:0)
[18:12:26.533] Build status: SCHEDULED
[18:12:26.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:10:0) after 2m49s
[18:15:15.599] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:10:0)
[18:15:15.776] Build status: SCHEDULED
[18:15:15.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:11:0) after 8m20s
[18:23:35.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:11:0)
[18:23:35.934] Build status: SCHEDULED
[18:23:35.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:12:0) after 2m58s
[18:26:34.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:12:0)
[18:26:34.229] Build status: SCHEDULED
[18:26:34.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:13:0) after 6m18s
[18:32:52.611] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:13:0)
[18:32:52.630] Build status: SCHEDULED
[18:32:52.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:14:0) after 7m44s
[18:40:36.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:14:0)
[18:40:37.058] Build status: SCHEDULED
[18:40:37.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:15:0) after 7m7s
[18:47:44.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:15:0)
[18:47:44.137] Build status: SCHEDULED
[18:47:44.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:16:0) after 8m9s
[18:55:53.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:16:0)
[18:55:53.252] Build status: SCHEDULED
[18:55:53.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:17:0) after 4m29s
[19:00:22.283] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:17:0)
[19:00:22.312] Build status: SCHEDULED
[19:00:22.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:18:0) after 6m29s
[19:06:51.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:18:0)
[19:06:51.481] Build status: SCHEDULED
[19:06:51.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:19:0) after 1m36s
[19:08:27.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:19:0)
[19:08:27.586] Build status: SCHEDULED
[19:08:27.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:20:0) after 9m37s
[19:18:04.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:20:0)
[19:18:04.787] Build status: SCHEDULED
[19:18:04.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:21:0) after 6m19s
[19:24:23.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:21:0)
[19:24:23.848] Build status: SCHEDULED
[19:24:23.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:22:0) after 7m37s
[19:32:00.991] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:22:0)
[19:32:01.013] Build status: SCHEDULED
[19:32:01.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:23:0) after 2m5s
[19:33:23.151] Received PubSub notification, asking Buildbucket for the build status
[19:33:23.329] Build status: STARTED
[19:34:06.292] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:23:0)
[19:34:06.346] Build status: STARTED
[19:34:06.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:25:0) after 6m39s
[19:40:45.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:25:0)
[19:40:45.389] Build status: STARTED
[19:40:45.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:26:0) after 1m31s
[19:42:16.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:26:0)
[19:42:16.462] Build status: STARTED
[19:42:16.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:27:0) after 1m50s
[19:44:06.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:27:0)
[19:44:06.691] Build status: STARTED
[19:44:06.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:28:0) after 2m43s
[19:46:49.753] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:28:0)
[19:46:49.800] Build status: STARTED
[19:46:49.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:29:0) after 9m42s
[19:56:31.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:29:0)
[19:56:31.843] Build status: STARTED
[19:56:31.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:30:0) after 8m20s
[20:04:52.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:30:0)
[20:04:52.095] Build status: STARTED
[20:04:52.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:31:0) after 4m54s
[20:09:46.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:31:0)
[20:09:46.147] Build status: STARTED
[20:09:46.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:32:0) after 5m31s
[20:15:17.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:32:0)
[20:15:17.197] Build status: STARTED
[20:15:17.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:33:0) after 4m18s
[20:19:35.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:33:0)
[20:19:35.240] Build status: STARTED
[20:19:35.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:34:0) after 6m44s
[20:26:19.413] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:34:0)
[20:26:19.449] Build status: STARTED
[20:26:19.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:35:0) after 5m18s
[20:31:37.531] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:35:0)
[20:31:37.565] Build status: STARTED
[20:31:37.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:36:0) after 8m9s
[20:39:46.837] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:36:0)
[20:39:46.873] Build status: STARTED
[20:39:46.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:37:0) after 7m14s
[20:47:01.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:37:0)
[20:47:01.198] Build status: STARTED
[20:47:01.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:38:0) after 2m9s
[20:49:10.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:38:0)
[20:49:10.350] Build status: STARTED
[20:49:10.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:39:0) after 2m53s
[20:52:03.636] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:39:0)
[20:52:03.681] Build status: STARTED
[20:52:03.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:40:0) after 3m55s
[20:55:58.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:40:0)
[20:55:58.739] Build status: STARTED
[20:55:58.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:41:0) after 3m43s
[20:59:41.762] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:41:0)
[20:59:41.782] Build status: STARTED
[20:59:41.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:42:0) after 3m18s
[21:02:59.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:42:0)
[21:02:59.834] Build status: STARTED
[21:02:59.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:43:0) after 5m55s
[21:08:54.954] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:43:0)
[21:08:54.978] Build status: STARTED
[21:08:54.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:44:0) after 2m58s
[21:11:53.015] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:44:0)
[21:11:53.036] Build status: STARTED
[21:11:53.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:45:0) after 7m9s
[21:19:02.288] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:45:0)
[21:19:02.317] Build status: STARTED
[21:19:02.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:46:0) after 7m52s
[21:26:54.473] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:46:0)
[21:26:54.492] Build status: STARTED
[21:26:54.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:47:0) after 4m30s
[21:31:24.512] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:47:0)
[21:31:24.538] Build status: STARTED
[21:31:24.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:48:0) after 6m17s
[21:37:41.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:48:0)
[21:37:41.581] Build status: STARTED
[21:37:41.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:49:0) after 6m9s
[21:43:50.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:49:0)
[21:43:50.623] Build status: STARTED
[21:43:50.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:50:0) after 4m46s
[21:48:36.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:50:0)
[21:48:36.669] Build status: STARTED
[21:48:36.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:51:0) after 5m45s
[21:54:21.752] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:51:0)
[21:54:21.772] Build status: STARTED
[21:54:21.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:52:0) after 2m44s
[21:57:05.944] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:52:0)
[21:57:05.983] Build status: STARTED
[21:57:05.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:53:0) after 4m19s
[22:01:25.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:53:0)
[22:01:25.249] Build status: STARTED
[22:01:25.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:54:0) after 5m38s
[22:07:03.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:54:0)
[22:07:03.476] Build status: STARTED
[22:07:03.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:55:0) after 6m12s
[22:13:15.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:55:0)
[22:13:15.537] Build status: STARTED
[22:13:15.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:56:0) after 9m10s
[22:22:25.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:56:0)
[22:22:25.598] Build status: STARTED
[22:22:25.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:57:0) after 7m53s
[22:30:18.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:57:0)
[22:30:18.745] Build status: STARTED
[22:30:18.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:58:0) after 2m13s
[22:32:32.005] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:58:0)
[22:32:32.025] Build status: STARTED
[22:32:32.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:59:0) after 4m30s
[22:37:02.052] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:59:0)
[22:37:02.079] Build status: STARTED
[22:37:02.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:60:0) after 6m40s
[22:43:42.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:60:0)
[22:43:42.243] Build status: STARTED
[22:43:42.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:61:0) after 4m52s
[22:48:34.268] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:61:0)
[22:48:34.289] Build status: STARTED
[22:48:34.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:62:0) after 3m37s
[22:52:11.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:62:0)
[22:52:11.408] Build status: STARTED
[22:52:11.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:63:0) after 5m23s
[22:57:34.559] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:63:0)
[22:57:34.579] Build status: STARTED
[22:57:34.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:64:0) after 5m59s
[23:03:33.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:64:0)
[23:03:33.766] Build status: STARTED
[23:03:33.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:65:0) after 2m46s
[23:06:19.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:65:0)
[23:06:19.838] Build status: STARTED
[23:06:19.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:66:0) after 9m54s
[23:16:13.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:66:0)
[23:16:13.985] Build status: STARTED
[23:16:13.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:67:0) after 5m59s
[23:22:13.088] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:67:0)
[23:22:13.117] Build status: STARTED
[23:22:13.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:68:0) after 1m27s
[23:23:40.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:68:0)
[23:23:40.262] Build status: STARTED
[23:23:40.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:69:0) after 6m22s
[23:30:02.336] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:69:0)
[23:30:02.378] Build status: STARTED
[23:30:02.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:70:0) after 2m14s
[23:32:16.401] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:70:0)
[23:32:16.418] Build status: STARTED
[23:32:16.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:71:0) after 4m58s
[23:37:14.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:71:0)
[23:37:14.547] Build status: STARTED
[23:37:14.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:72:0) after 1m7s
[23:38:21.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:72:0)
[23:38:21.623] Build status: STARTED
[23:38:21.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:73:0) after 6m13s
[23:44:34.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:73:0)
[23:44:34.741] Build status: STARTED
[23:44:34.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:74:0) after 9m32s
[23:54:06.775] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:74:0)
[23:54:06.838] Build status: STARTED
[23:54:06.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:75:0) after 4m24s
[23:58:30.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:75:0)
[23:58:30.993] Build status: STARTED
[23:58:30.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:76:0) after 6m32s
[00:05:03.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:76:0)
[00:05:03.188] Build status: STARTED
[00:05:03.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:77:0) after 7m38s
[00:12:41.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:77:0)
[00:12:41.379] Build status: STARTED
[00:12:41.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:78:0) after 2m29s
[00:15:10.471] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:78:0)
[00:15:10.523] Build status: STARTED
[00:15:10.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:79:0) after 9m32s
[00:24:42.719] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:79:0)
[00:24:42.738] Build status: STARTED
[00:24:42.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:80:0) after 8m55s
[00:33:37.845] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:80:0)
[00:33:37.874] Build status: STARTED
[00:33:37.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:81:0) after 2m33s
[00:36:11.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:81:0)
[00:36:11.065] Build status: STARTED
[00:36:11.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:82:0) after 5m12s
[00:41:23.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:82:0)
[00:41:23.213] Build status: STARTED
[00:41:23.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:83:0) after 3m5s
[00:44:28.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:83:0)
[00:44:28.362] Build status: STARTED
[00:44:28.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:84:0) after 4m17s
[00:48:45.580] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:84:0)
[00:48:45.605] Build status: STARTED
[00:48:45.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:85:0) after 2m10s
[00:50:55.633] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:85:0)
[00:50:55.655] Build status: STARTED
[00:50:55.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:86:0) after 7m12s
[00:58:07.966] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:86:0)
[00:58:08.008] Build status: STARTED
[00:58:08.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:87:0) after 3m40s
[01:01:48.140] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:87:0)
[01:01:48.166] Build status: STARTED
[01:01:48.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:88:0) after 8m38s
[01:10:26.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:88:0)
[01:10:26.489] Build status: STARTED
[01:10:26.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:89:0) after 5m6s
[01:15:32.602] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:89:0)
[01:15:32.652] Build status: STARTED
[01:15:32.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:90:0) after 4m25s
[01:19:57.675] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:90:0)
[01:19:57.709] Build status: STARTED
[01:19:57.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:91:0) after 4m12s
[01:24:09.730] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:91:0)
[01:24:09.759] Build status: STARTED
[01:24:09.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:92:0) after 7m51s
[01:32:00.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:92:0)
[01:32:00.814] Build status: STARTED
[01:32:00.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:93:0) after 9m1s
[01:41:01.867] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:93:0)
[01:41:01.888] Build status: STARTED
[01:41:01.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:94:0) after 1m21s
[01:42:23.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:94:0)
[01:42:23.040] Build status: STARTED
[01:42:23.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:95:0) after 7m48s
[01:50:11.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:95:0)
[01:50:11.177] Build status: STARTED
[01:50:11.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:96:0) after 7m47s
[01:57:58.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:96:0)
[01:57:58.330] Build status: STARTED
[01:57:58.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:97:0) after 3m0s
[02:00:58.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:97:0)
[02:00:58.441] Build status: STARTED
[02:00:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:98:0) after 1m58s
[02:02:56.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:98:0)
[02:02:56.449] Build status: STARTED
[02:02:56.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:99:0) after 3m28s
[02:06:24.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:99:0)
[02:06:24.547] Build status: STARTED
[02:06:24.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:100:0) after 4m28s
[02:10:52.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:100:0)
[02:10:52.756] Build status: STARTED
[02:10:52.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:101:0) after 4m33s
[02:15:25.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:101:0)
[02:15:25.852] Build status: STARTED
[02:15:25.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:102:0) after 9m34s
[02:24:59.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:102:0)
[02:24:59.898] Build status: STARTED
[02:24:59.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:103:0) after 5m38s
[02:30:38.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:103:0)
[02:30:38.148] Build status: STARTED
[02:30:38.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:104:0) after 2m14s
[02:32:52.241] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:104:0)
[02:32:52.273] Build status: STARTED
[02:32:52.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:105:0) after 4m49s
[02:37:41.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:105:0)
[02:37:41.317] Build status: STARTED
[02:37:41.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:106:0) after 2m50s
[02:40:31.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:106:0)
[02:40:31.478] Build status: STARTED
[02:40:31.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:107:0) after 8m30s
[02:49:01.504] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:107:0)
[02:49:01.524] Build status: STARTED
[02:49:01.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:108:0) after 3m27s
[02:52:28.582] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:108:0)
[02:52:28.602] Build status: STARTED
[02:52:28.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:109:0) after 9m34s
[03:02:02.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:109:0)
[03:02:02.704] Build status: STARTED
[03:02:02.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:110:0) after 4m10s
[03:06:12.846] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:110:0)
[03:06:12.874] Build status: STARTED
[03:06:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:111:0) after 1m31s
[03:07:43.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:111:0)
[03:07:43.987] Build status: STARTED
[03:07:43.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:112:0) after 1m13s
[03:08:56.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:112:0)
[03:08:56.996] Build status: STARTED
[03:08:56.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:113:0) after 5m48s
[03:14:45.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:113:0)
[03:14:45.042] Build status: STARTED
[03:14:45.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:114:0) after 7m57s
[03:22:42.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:114:0)
[03:22:42.294] Build status: STARTED
[03:22:42.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:115:0) after 3m28s
[03:26:10.355] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:115:0)
[03:26:10.422] Build status: STARTED
[03:26:10.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:116:0) after 7m22s
[03:33:32.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:116:0)
[03:33:32.475] Build status: STARTED
[03:33:32.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:117:0) after 7m11s
[03:40:43.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:117:0)
[03:40:43.534] Build status: STARTED
[03:40:43.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:118:0) after 6m24s
[03:47:07.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:118:0)
[03:47:07.609] Build status: STARTED
[03:47:07.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:119:0) after 4m32s
[03:51:39.765] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:119:0)
[03:51:39.793] Build status: STARTED
[03:51:39.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:120:0) after 8m38s
[04:00:17.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:120:0)
[04:00:17.860] Build status: STARTED
[04:00:17.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:121:0) after 3m10s
[04:03:27.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:121:0)
[04:03:27.912] Build status: STARTED
[04:03:27.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:122:0) after 7m41s
[04:11:09.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:122:0)
[04:11:09.068] Build status: STARTED
[04:11:09.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:123:0) after 8m17s
[04:19:26.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:123:0)
[04:19:26.478] Build status: STARTED
[04:19:26.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:124:0) after 9m45s
[04:29:11.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:124:0)
[04:29:11.770] Build status: STARTED
[04:29:11.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:125:0) after 3m53s
[04:33:04.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:125:0)
[04:33:04.929] Build status: STARTED
[04:33:04.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:126:0) after 8m45s
[04:41:49.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:126:0)
[04:41:49.985] Build status: STARTED
[04:41:49.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:127:0) after 4m1s
[04:45:51.401] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:127:0)
[04:45:51.422] Build status: STARTED
[04:45:51.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8992465522167918208:128:0) after 7m16s
[04:50:57.460] Received PubSub notification, asking Buildbucket for the build status
[04:50:57.487] Build:
{
"id": "8827035458749129521",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9482,
"createdBy": "project:chromium",
"createTime": "2021-12-23T17:20:15.191665883Z",
"startTime": "2021-12-23T19:33:22.325367Z",
"endTime": "2021-12-24T04:50:57.048416228Z",
"updateTime": "2021-12-24T04:50:57.048416228Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fa0ef429b1f3f47bd3877e6c610acff006bdd7c",
"ref": "refs/heads/main"
}
}
}
[04:50:57.487] Invocation finished in 11h30m44.940076411s with status FAILED