[19:55:56.070] New invocation is queued and will start shortly
[19:55:57.218] Starting the invocation (attempt 1)
[19:55:57.262] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/864d63fd5b650e29da3dca965d8ef929a1aee8e8"
[19:55:57.262] Popped gitiles commit info from properties and tags
[19:55:57.262] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:55:57.263] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:55:57.263] Buildbucket request:
{
"requestId": "8990462591530245648",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "864d63fd5b650e29da3dca965d8ef929a1aee8e8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8990462591530245648"
},
{
"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"
}
}
[19:55:57.793] Scheduled build:
{
"id": "8825032529539474353",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9586,
"createdBy": "project:chromium",
"createTime": "2022-01-14T19:55:57.336461506Z",
"updateTime": "2022-01-14T19:55:57.336461506Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "864d63fd5b650e29da3dca965d8ef929a1aee8e8",
"ref": "refs/heads/main"
}
}
}
[19:55:57.793] Task URL: https://cr-buildbucket.appspot.com/build/8825032529539474353
[19:55:57.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:2:0) after 9m28s
[20:05:25.921] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:2:0)
[20:05:25.948] Build status: SCHEDULED
[20:05:25.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:3:0) after 4m46s
[20:10:11.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:3:0)
[20:10:12.018] Build status: SCHEDULED
[20:10:12.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:4:0) after 7m47s
[20:10:44.558] Received PubSub notification, asking Buildbucket for the build status
[20:10:44.599] Build status: STARTED
[20:17:59.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:4:0)
[20:17:59.081] Build status: STARTED
[20:17:59.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:6:0) after 9m56s
[20:27:55.367] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:6:0)
[20:27:55.401] Build status: STARTED
[20:27:55.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:7:0) after 1m41s
[20:29:36.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:7:0)
[20:29:36.555] Build status: STARTED
[20:29:36.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:8:0) after 2m38s
[20:32:14.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:8:0)
[20:32:14.718] Build status: STARTED
[20:32:14.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:9:0) after 9m1s
[20:41:15.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:9:0)
[20:41:15.779] Build status: STARTED
[20:41:15.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:10:0) after 5m29s
[20:46:44.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:10:0)
[20:46:44.842] Build status: STARTED
[20:46:44.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:11:0) after 8m23s
[20:55:07.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:11:0)
[20:55:07.948] Build status: STARTED
[20:55:07.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:12:0) after 1m36s
[20:56:43.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:12:0)
[20:56:43.957] Build status: STARTED
[20:56:43.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:13:0) after 2m1s
[20:58:44.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:13:0)
[20:58:45.021] Build status: STARTED
[20:58:45.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:14:0) after 5m26s
[21:04:11.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:14:0)
[21:04:11.188] Build status: STARTED
[21:04:11.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:15:0) after 6m46s
[21:10:57.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:15:0)
[21:10:57.430] Build status: STARTED
[21:10:57.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:16:0) after 4m17s
[21:15:14.557] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:16:0)
[21:15:14.587] Build status: STARTED
[21:15:14.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:17:0) after 2m40s
[21:17:54.616] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:17:0)
[21:17:54.658] Build status: STARTED
[21:17:54.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:18:0) after 9m15s
[21:27:09.695] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:18:0)
[21:27:09.742] Build status: STARTED
[21:27:09.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:19:0) after 9m10s
[21:36:19.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:19:0)
[21:36:19.798] Build status: STARTED
[21:36:19.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:20:0) after 2m19s
[21:38:39.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:20:0)
[21:38:39.084] Build status: STARTED
[21:38:39.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:21:0) after 7m55s
[21:46:34.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:21:0)
[21:46:34.397] Build status: STARTED
[21:46:34.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:22:0) after 9m41s
[21:56:15.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:22:0)
[21:56:15.726] Build status: STARTED
[21:56:15.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:23:0) after 9m41s
[22:05:56.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:23:0)
[22:05:56.799] Build status: STARTED
[22:05:56.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:24:0) after 9m29s
[22:15:25.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:24:0)
[22:15:25.860] Build status: STARTED
[22:15:25.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:25:0) after 9m50s
[22:25:15.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:25:0)
[22:25:15.985] Build status: STARTED
[22:25:15.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:26:0) after 9m22s
[22:34:38.038] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:26:0)
[22:34:38.067] Build status: STARTED
[22:34:38.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:27:0) after 4m35s
[22:39:13.085] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:27:0)
[22:39:13.131] Build status: STARTED
[22:39:13.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:28:0) after 6m43s
[22:45:56.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:28:0)
[22:45:56.178] Build status: STARTED
[22:45:56.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:29:0) after 4m44s
[22:50:40.205] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:29:0)
[22:50:40.233] Build status: STARTED
[22:50:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:30:0) after 3m48s
[22:54:28.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:30:0)
[22:54:28.279] Build status: STARTED
[22:54:28.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:31:0) after 3m24s
[22:57:52.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:31:0)
[22:57:52.949] Build status: STARTED
[22:57:52.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:32:0) after 9m1s
[23:06:53.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:32:0)
[23:06:53.999] Build status: STARTED
[23:06:53.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:33:0) after 9m4s
[23:15:58.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:33:0)
[23:15:58.136] Build status: STARTED
[23:15:58.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:34:0) after 5m17s
[23:21:15.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:34:0)
[23:21:15.356] Build status: STARTED
[23:21:15.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:35:0) after 3m5s
[23:24:20.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:35:0)
[23:24:20.602] Build status: STARTED
[23:24:20.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:36:0) after 1m20s
[23:25:40.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:36:0)
[23:25:40.856] Build status: STARTED
[23:25:40.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:37:0) after 4m8s
[23:29:49.214] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:37:0)
[23:29:49.244] Build status: STARTED
[23:29:49.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:38:0) after 7m25s
[23:37:14.317] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:38:0)
[23:37:14.335] Build status: STARTED
[23:37:14.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:39:0) after 3m19s
[23:40:33.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:39:0)
[23:40:33.407] Build status: STARTED
[23:40:33.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:40:0) after 8m2s
[23:48:35.504] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:40:0)
[23:48:35.523] Build status: STARTED
[23:48:35.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:41:0) after 5m46s
[23:54:21.589] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:41:0)
[23:54:21.612] Build status: STARTED
[23:54:21.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:42:0) after 2m30s
[23:56:51.719] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:42:0)
[23:56:51.738] Build status: STARTED
[23:56:51.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:43:0) after 8m10s
[00:05:01.870] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:43:0)
[00:05:01.895] Build status: STARTED
[00:05:01.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:44:0) after 3m41s
[00:08:43.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:44:0)
[00:08:43.121] Build status: STARTED
[00:08:43.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:45:0) after 8m18s
[00:17:01.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:45:0)
[00:17:01.295] Build status: STARTED
[00:17:01.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:46:0) after 6m14s
[00:23:15.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:46:0)
[00:23:15.670] Build status: STARTED
[00:23:15.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:47:0) after 4m54s
[00:28:09.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:47:0)
[00:28:09.731] Build status: STARTED
[00:28:09.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:48:0) after 9m56s
[00:38:05.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:48:0)
[00:38:05.897] Build status: STARTED
[00:38:05.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:49:0) after 5m19s
[00:43:24.948] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:49:0)
[00:43:25.091] Build status: STARTED
[00:43:25.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:50:0) after 2m58s
[00:46:23.743] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:50:0)
[00:46:23.764] Build status: STARTED
[00:46:23.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:51:0) after 9m12s
[00:55:36.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:51:0)
[00:55:36.034] Build status: STARTED
[00:55:36.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:52:0) after 2m38s
[00:58:14.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:52:0)
[00:58:14.143] Build status: STARTED
[00:58:14.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:53:0) after 3m36s
[01:01:50.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:53:0)
[01:01:50.990] Build status: STARTED
[01:01:50.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:54:0) after 5m42s
[01:07:33.078] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:54:0)
[01:07:33.100] Build status: STARTED
[01:07:33.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:55:0) after 4m20s
[01:11:53.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:55:0)
[01:11:53.259] Build status: STARTED
[01:11:53.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:56:0) after 2m7s
[01:14:00.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:56:0)
[01:14:00.445] Build status: STARTED
[01:14:00.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:57:0) after 3m17s
[01:17:17.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:57:0)
[01:17:17.518] Build status: STARTED
[01:17:17.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:58:0) after 7m52s
[01:25:09.610] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:58:0)
[01:25:09.638] Build status: STARTED
[01:25:09.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:59:0) after 2m17s
[01:27:26.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:59:0)
[01:27:26.887] Build status: STARTED
[01:27:26.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:60:0) after 8m5s
[01:35:32.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:60:0)
[01:35:32.077] Build status: STARTED
[01:35:32.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:61:0) after 2m34s
[01:38:06.106] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:61:0)
[01:38:06.129] Build status: STARTED
[01:38:06.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:62:0) after 5m18s
[01:43:24.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:62:0)
[01:43:24.372] Build status: STARTED
[01:43:24.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:63:0) after 6m59s
[01:50:23.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:63:0)
[01:50:23.723] Build status: STARTED
[01:50:23.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:64:0) after 5m25s
[01:55:49.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:64:0)
[01:55:49.119] Build status: STARTED
[01:55:49.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:65:0) after 9m55s
[02:05:45.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:65:0)
[02:05:45.091] Build status: STARTED
[02:05:45.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:66:0) after 8m30s
[02:14:15.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:66:0)
[02:14:15.353] Build status: STARTED
[02:14:15.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:67:0) after 5m27s
[02:19:42.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:67:0)
[02:19:42.436] Build status: STARTED
[02:19:42.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:68:0) after 1m58s
[02:21:41.236] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:68:0)
[02:21:41.272] Build status: STARTED
[02:21:41.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:69:0) after 1m25s
[02:23:06.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:69:0)
[02:23:06.652] Build status: STARTED
[02:23:06.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:70:0) after 8m33s
[02:31:39.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:70:0)
[02:31:39.707] Build status: STARTED
[02:31:39.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:71:0) after 5m59s
[02:37:38.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:71:0)
[02:37:38.837] Build status: STARTED
[02:37:38.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:72:0) after 6m14s
[02:43:52.934] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:72:0)
[02:43:52.962] Build status: STARTED
[02:43:52.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:73:0) after 3m25s
[02:47:17.991] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:73:0)
[02:47:18.010] Build status: STARTED
[02:47:18.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:74:0) after 1m5s
[02:48:23.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:74:0)
[02:48:23.108] Build status: STARTED
[02:48:23.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:75:0) after 2m14s
[02:50:37.280] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:75:0)
[02:50:37.311] Build status: STARTED
[02:50:37.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:76:0) after 4m54s
[02:55:31.367] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:76:0)
[02:55:31.396] Build status: STARTED
[02:55:31.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:77:0) after 1m38s
[02:57:09.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:77:0)
[02:57:09.515] Build status: STARTED
[02:57:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:78:0) after 5m17s
[03:02:26.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:78:0)
[03:02:26.583] Build status: STARTED
[03:02:26.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:79:0) after 4m38s
[03:07:04.668] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:79:0)
[03:07:04.690] Build status: STARTED
[03:07:04.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:80:0) after 6m47s
[03:13:51.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:80:0)
[03:13:51.749] Build status: STARTED
[03:13:51.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:81:0) after 2m12s
[03:16:03.900] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:81:0)
[03:16:03.934] Build status: STARTED
[03:16:03.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:82:0) after 1m32s
[03:17:36.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:82:0)
[03:17:36.091] Build status: STARTED
[03:17:36.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:83:0) after 3m44s
[03:21:20.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:83:0)
[03:21:20.219] Build status: STARTED
[03:21:20.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:84:0) after 3m47s
[03:25:07.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:84:0)
[03:25:07.291] Build status: STARTED
[03:25:07.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:85:0) after 1m35s
[03:26:42.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:85:0)
[03:26:42.536] Build status: STARTED
[03:26:42.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:86:0) after 2m10s
[03:28:52.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:86:0)
[03:28:52.683] Build status: STARTED
[03:28:52.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:87:0) after 5m40s
[03:34:32.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:87:0)
[03:34:32.883] Build status: STARTED
[03:34:32.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:88:0) after 3m28s
[03:38:01.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:88:0)
[03:38:01.338] Build status: STARTED
[03:38:01.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:89:0) after 2m28s
[03:40:29.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:89:0)
[03:40:29.456] Build status: STARTED
[03:40:29.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:90:0) after 1m55s
[03:42:24.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:90:0)
[03:42:24.741] Build status: STARTED
[03:42:24.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:91:0) after 8m39s
[03:51:03.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:91:0)
[03:51:03.891] Build status: STARTED
[03:51:03.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:92:0) after 9m10s
[04:00:13.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:92:0)
[04:00:14.098] Build status: STARTED
[04:00:14.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:93:0) after 4m22s
[04:04:36.391] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:93:0)
[04:04:36.414] Build status: STARTED
[04:04:36.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:94:0) after 7m47s
[04:12:23.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:94:0)
[04:12:23.854] Build status: STARTED
[04:12:23.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:95:0) after 3m45s
[04:16:08.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:95:0)
[04:16:08.910] Build status: STARTED
[04:16:08.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:96:0) after 4m48s
[04:20:56.942] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:96:0)
[04:20:56.962] Build status: STARTED
[04:20:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:97:0) after 9m16s
[04:30:12.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:97:0)
[04:30:13.056] Build status: STARTED
[04:30:13.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:98:0) after 1m33s
[04:31:46.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:98:0)
[04:31:46.334] Build status: STARTED
[04:31:46.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:99:0) after 9m40s
[04:41:26.464] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:99:0)
[04:41:26.518] Build status: STARTED
[04:41:26.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:100:0) after 7m51s
[04:49:17.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:100:0)
[04:49:17.568] Build status: STARTED
[04:49:17.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:101:0) after 6m43s
[04:56:00.599] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:101:0)
[04:56:00.636] Build status: STARTED
[04:56:00.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:102:0) after 9m57s
[05:05:57.666] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:102:0)
[05:05:57.687] Build status: STARTED
[05:05:57.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:103:0) after 1m48s
[05:07:45.717] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:103:0)
[05:07:45.786] Build status: STARTED
[05:07:45.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:104:0) after 7m25s
[05:15:11.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:104:0)
[05:15:11.358] Build status: STARTED
[05:15:11.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:105:0) after 9m15s
[05:24:26.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:105:0)
[05:24:26.412] Build status: STARTED
[05:24:26.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:106:0) after 4m38s
[05:29:04.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:106:0)
[05:29:04.475] Build status: STARTED
[05:29:04.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:107:0) after 6m21s
[05:35:25.505] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:107:0)
[05:35:25.548] Build status: STARTED
[05:35:25.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:108:0) after 9m58s
[05:45:23.626] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:108:0)
[05:45:23.653] Build status: STARTED
[05:45:23.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:109:0) after 6m6s
[05:51:29.714] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:109:0)
[05:51:29.754] Build status: STARTED
[05:51:29.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:110:0) after 7m55s
[05:59:24.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:110:0)
[05:59:24.774] Build status: STARTED
[05:59:24.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:111:0) after 6m14s
[06:05:38.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:111:0)
[06:05:38.822] Build status: STARTED
[06:05:38.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:112:0) after 4m32s
[06:10:10.882] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:112:0)
[06:10:10.950] Build status: STARTED
[06:10:10.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:113:0) after 7m49s
[06:18:00.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:113:0)
[06:18:00.029] Build status: STARTED
[06:18:00.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:114:0) after 7m10s
[06:25:10.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:114:0)
[06:25:10.120] Build status: STARTED
[06:25:10.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:115:0) after 7m46s
[06:32:56.243] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:115:0)
[06:32:56.272] Build status: STARTED
[06:32:56.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:116:0) after 1m58s
[06:34:54.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:116:0)
[06:34:54.348] Build status: STARTED
[06:34:54.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:117:0) after 5m43s
[06:40:37.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:117:0)
[06:40:37.472] Build status: STARTED
[06:40:37.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dll):8990462591530245648:118:0) after 7m20s
[06:45:08.319] Received PubSub notification, asking Buildbucket for the build status
[06:45:08.382] Build:
{
"id": "8825032529539474353",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dll)"
},
"number": 9586,
"createdBy": "project:chromium",
"createTime": "2022-01-14T19:55:57.336461506Z",
"startTime": "2022-01-14T20:10:43.670112Z",
"endTime": "2022-01-15T06:45:07.850550440Z",
"updateTime": "2022-01-15T06:45:07.850550440Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "864d63fd5b650e29da3dca965d8ef929a1aee8e8",
"ref": "refs/heads/main"
}
}
}
[06:45:08.382] Invocation finished in 10h49m12.328073676s with status FAILED