[05:01:16.703] New invocation is queued and will start shortly
[05:01:17.878] Starting the invocation (attempt 1)
[05:01:17.921] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/88fbd48c6783e0602a46027edaf257a22b50251a"
[05:01:17.921] Popped gitiles commit info from properties and tags
[05:01:17.921] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:01:17.922] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:01:17.922] Buildbucket request:
{
"requestId": "9001481111361037728",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "88fbd48c6783e0602a46027edaf257a22b50251a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9001481111361037728"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:01:18.473] Scheduled build:
{
"id": "8836051049313888785",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"number": 381,
"createdBy": "project:chromium",
"createTime": "2021-09-15T05:01:18.022636578Z",
"updateTime": "2021-09-15T05:01:18.278284930Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "88fbd48c6783e0602a46027edaf257a22b50251a",
"ref": "refs/heads/main"
}
}
}
[05:01:18.473] Task URL: https://cr-buildbucket.appspot.com/build/8836051049313888785
[05:01:18.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:2:0) after 3m44s
[05:05:02.913] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:2:0)
[05:05:02.961] Build status: SCHEDULED
[05:05:02.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:3:0) after 2m16s
[05:07:19.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:3:0)
[05:07:19.034] Build status: SCHEDULED
[05:07:19.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:4:0) after 3m55s
[05:11:14.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:4:0)
[05:11:14.089] Build status: SCHEDULED
[05:11:14.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:5:0) after 5m23s
[05:16:37.117] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:5:0)
[05:16:37.191] Build status: SCHEDULED
[05:16:37.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:6:0) after 2m58s
[05:19:35.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:6:0)
[05:19:35.598] Build status: SCHEDULED
[05:19:35.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:7:0) after 7m19s
[05:26:54.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:7:0)
[05:26:54.666] Build status: SCHEDULED
[05:26:54.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:8:0) after 7m50s
[05:34:44.955] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:8:0)
[05:34:45.001] Build status: SCHEDULED
[05:34:45.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:9:0) after 3m20s
[05:38:05.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:9:0)
[05:38:05.066] Build status: SCHEDULED
[05:38:05.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:10:0) after 5m43s
[05:43:48.285] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:10:0)
[05:43:48.313] Build status: SCHEDULED
[05:43:48.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:11:0) after 8m2s
[05:51:50.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:11:0)
[05:51:50.393] Build status: SCHEDULED
[05:51:50.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:12:0) after 8m25s
[05:54:51.709] Received PubSub notification, asking Buildbucket for the build status
[05:54:51.742] Build status: STARTED
[06:00:15.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:12:0)
[06:00:15.473] Build status: STARTED
[06:00:15.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:14:0) after 2m10s
[06:02:25.666] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:14:0)
[06:02:25.714] Build status: STARTED
[06:02:25.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:15:0) after 8m45s
[06:11:10.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:15:0)
[06:11:10.966] Build status: STARTED
[06:11:10.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:16:0) after 1m8s
[06:12:18.989] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:16:0)
[06:12:19.038] Build status: STARTED
[06:12:19.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:17:0) after 5m53s
[06:18:12.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:17:0)
[06:18:12.101] Build status: STARTED
[06:18:12.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:18:0) after 1m2s
[06:19:14.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:18:0)
[06:19:14.199] Build status: STARTED
[06:19:14.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:19:0) after 3m54s
[06:23:08.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:19:0)
[06:23:08.484] Build status: STARTED
[06:23:08.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:20:0) after 4m57s
[06:28:05.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:20:0)
[06:28:05.642] Build status: STARTED
[06:28:05.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:21:0) after 1m58s
[06:30:03.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:21:0)
[06:30:03.904] Build status: STARTED
[06:30:03.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:22:0) after 5m50s
[06:35:54.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:22:0)
[06:35:54.056] Build status: STARTED
[06:35:54.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:23:0) after 9m28s
[06:45:22.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:23:0)
[06:45:22.246] Build status: STARTED
[06:45:22.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:24:0) after 9m6s
[06:54:28.296] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:24:0)
[06:54:28.337] Build status: STARTED
[06:54:28.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:25:0) after 1m25s
[06:55:53.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:25:0)
[06:55:53.784] Build status: STARTED
[06:55:53.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:26:0) after 2m23s
[06:58:16.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:26:0)
[06:58:17.274] Build status: STARTED
[06:58:17.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:27:0) after 2m1s
[07:00:18.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:27:0)
[07:00:18.468] Build status: STARTED
[07:00:18.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:28:0) after 5m9s
[07:05:27.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:28:0)
[07:05:27.685] Build status: STARTED
[07:05:27.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:29:0) after 5m21s
[07:10:48.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:29:0)
[07:10:48.739] Build status: STARTED
[07:10:48.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:30:0) after 2m7s
[07:12:55.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:30:0)
[07:12:55.798] Build status: STARTED
[07:12:55.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:31:0) after 2m31s
[07:15:26.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:31:0)
[07:15:27.049] Build status: STARTED
[07:15:27.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:32:0) after 4m13s
[07:19:40.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:32:0)
[07:19:40.107] Build status: STARTED
[07:19:40.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:33:0) after 7m33s
[07:27:13.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:33:0)
[07:27:13.407] Build status: STARTED
[07:27:13.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:34:0) after 2m32s
[07:29:45.557] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:34:0)
[07:29:45.590] Build status: STARTED
[07:29:45.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:35:0) after 9m1s
[07:38:46.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:35:0)
[07:38:46.651] Build status: STARTED
[07:38:46.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:36:0) after 7m8s
[07:45:54.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:36:0)
[07:45:54.784] Build status: STARTED
[07:45:54.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:37:0) after 1m32s
[07:47:26.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:37:0)
[07:47:26.971] Build status: STARTED
[07:47:26.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:38:0) after 2m25s
[07:49:52.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:38:0)
[07:49:52.576] Build status: STARTED
[07:49:52.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:39:0) after 4m9s
[07:54:01.606] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:39:0)
[07:54:01.647] Build status: STARTED
[07:54:01.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:40:0) after 1m13s
[07:55:14.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:40:0)
[07:55:14.717] Build status: STARTED
[07:55:14.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:41:0) after 9m49s
[08:05:04.089] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:41:0)
[08:05:04.121] Build status: STARTED
[08:05:04.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:42:0) after 3m57s
[08:09:01.296] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:42:0)
[08:09:01.326] Build status: STARTED
[08:09:01.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:43:0) after 9m49s
[08:18:50.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:43:0)
[08:18:50.525] Build status: STARTED
[08:18:50.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:44:0) after 6m50s
[08:25:40.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:44:0)
[08:25:40.613] Build status: STARTED
[08:25:40.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:45:0) after 1m27s
[08:27:07.640] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:45:0)
[08:27:07.667] Build status: STARTED
[08:27:07.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:46:0) after 8m7s
[08:35:14.897] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:46:0)
[08:35:14.960] Build status: STARTED
[08:35:14.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:47:0) after 3m8s
[08:38:22.997] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:47:0)
[08:38:23.051] Build status: STARTED
[08:38:23.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:48:0) after 4m40s
[08:43:03.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:48:0)
[08:43:03.476] Build status: STARTED
[08:43:03.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:49:0) after 8m26s
[08:51:29.594] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:49:0)
[08:51:29.662] Build status: STARTED
[08:51:29.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:50:0) after 6m12s
[08:57:41.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:50:0)
[08:57:41.879] Build status: STARTED
[08:57:41.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:51:0) after 6m56s
[09:04:37.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:51:0)
[09:04:37.984] Build status: STARTED
[09:04:37.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:52:0) after 7m6s
[09:11:44.013] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:52:0)
[09:11:44.047] Build status: STARTED
[09:11:44.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:53:0) after 5m58s
[09:17:42.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:53:0)
[09:17:42.112] Build status: STARTED
[09:17:42.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:54:0) after 1m30s
[09:19:12.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:54:0)
[09:19:12.277] Build status: STARTED
[09:19:12.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:55:0) after 9m56s
[09:29:08.415] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:55:0)
[09:29:08.459] Build status: STARTED
[09:29:08.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:56:0) after 6m8s
[09:35:16.627] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:56:0)
[09:35:16.664] Build status: STARTED
[09:35:16.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:57:0) after 4m39s
[09:39:55.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:57:0)
[09:39:55.842] Build status: STARTED
[09:39:55.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:58:0) after 5m9s
[09:45:05.069] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:58:0)
[09:45:05.193] Build status: STARTED
[09:45:05.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:59:0) after 3m4s
[09:48:09.239] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:59:0)
[09:48:09.304] Build status: STARTED
[09:48:09.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:60:0) after 6m13s
[09:54:22.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:60:0)
[09:54:22.375] Build status: STARTED
[09:54:22.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:61:0) after 7m57s
[10:02:19.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:61:0)
[10:02:19.518] Build status: STARTED
[10:02:19.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:62:0) after 3m56s
[10:06:15.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:62:0)
[10:06:15.858] Build status: STARTED
[10:06:15.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:63:0) after 8m4s
[10:14:19.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:63:0)
[10:14:19.918] Build status: STARTED
[10:14:19.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:64:0) after 9m42s
[10:24:02.080] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:64:0)
[10:24:02.116] Build status: STARTED
[10:24:02.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:65:0) after 9m42s
[10:33:44.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:65:0)
[10:33:44.432] Build status: STARTED
[10:33:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:66:0) after 8m13s
[10:41:57.588] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:66:0)
[10:41:57.661] Build status: STARTED
[10:41:57.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:67:0) after 7m6s
[10:49:03.833] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:67:0)
[10:49:03.975] Build status: STARTED
[10:49:03.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:68:0) after 9m7s
[10:58:11.055] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:68:0)
[10:58:11.160] Build status: STARTED
[10:58:11.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:69:0) after 5m55s
[11:04:06.189] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:69:0)
[11:04:06.224] Build status: STARTED
[11:04:06.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:70:0) after 2m43s
[11:06:49.289] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:70:0)
[11:06:49.369] Build status: STARTED
[11:06:49.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:71:0) after 2m4s
[11:08:53.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:71:0)
[11:08:53.402] Build status: STARTED
[11:08:53.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:72:0) after 7m10s
[11:16:03.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:72:0)
[11:16:03.480] Build status: STARTED
[11:16:03.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:73:0) after 2m18s
[11:18:21.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:73:0)
[11:18:21.554] Build status: STARTED
[11:18:21.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:74:0) after 5m50s
[11:24:11.692] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:74:0)
[11:24:11.727] Build status: STARTED
[11:24:11.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:75:0) after 9m1s
[11:33:12.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:75:0)
[11:33:12.849] Build status: STARTED
[11:33:12.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:76:0) after 8m38s
[11:41:50.940] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:76:0)
[11:41:50.987] Build status: STARTED
[11:41:50.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:77:0) after 7m16s
[11:49:07.134] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:77:0)
[11:49:07.167] Build status: STARTED
[11:49:07.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:78:0) after 3m4s
[11:52:11.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:78:0)
[11:52:11.424] Build status: STARTED
[11:52:11.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:79:0) after 4m7s
[11:56:18.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:79:0)
[11:56:18.487] Build status: STARTED
[11:56:18.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:80:0) after 2m13s
[11:58:32.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:80:0)
[11:58:32.354] Build status: STARTED
[11:58:32.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:81:0) after 2m51s
[12:01:23.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:81:0)
[12:01:23.492] Build status: STARTED
[12:01:23.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:82:0) after 5m51s
[12:07:14.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:82:0)
[12:07:14.817] Build status: STARTED
[12:07:14.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:83:0) after 4m46s
[12:12:00.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:83:0)
[12:12:00.955] Build status: STARTED
[12:12:00.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:84:0) after 5m47s
[12:17:48.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:84:0)
[12:17:48.547] Build status: STARTED
[12:17:48.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:85:0) after 3m55s
[12:21:43.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:85:0)
[12:21:43.651] Build status: STARTED
[12:21:43.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:86:0) after 4m42s
[12:26:25.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:86:0)
[12:26:25.920] Build status: STARTED
[12:26:25.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:87:0) after 8m25s
[12:34:50.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:87:0)
[12:34:51.007] Build status: STARTED
[12:34:51.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:88:0) after 7m27s
[12:42:18.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:88:0)
[12:42:18.068] Build status: STARTED
[12:42:18.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:89:0) after 9m17s
[12:51:35.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:89:0)
[12:51:35.109] Build status: STARTED
[12:51:35.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:90:0) after 8m42s
[13:00:17.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:90:0)
[13:00:17.569] Build status: STARTED
[13:00:17.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:91:0) after 7m15s
[13:07:32.753] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:91:0)
[13:07:32.864] Build status: STARTED
[13:07:32.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:92:0) after 6m17s
[13:13:49.901] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:92:0)
[13:13:49.975] Build status: STARTED
[13:13:49.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:93:0) after 8m2s
[13:21:52.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:93:0)
[13:21:52.190] Build status: STARTED
[13:21:52.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:94:0) after 6m15s
[13:28:07.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:94:0)
[13:28:07.269] Build status: STARTED
[13:28:07.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:95:0) after 5m18s
[13:33:25.469] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:95:0)
[13:33:25.502] Build status: STARTED
[13:33:25.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:96:0) after 1m59s
[13:35:24.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:96:0)
[13:35:24.679] Build status: STARTED
[13:35:24.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:97:0) after 5m32s
[13:40:56.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:97:0)
[13:40:56.737] Build status: STARTED
[13:40:56.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:98:0) after 2m45s
[13:43:41.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:98:0)
[13:43:41.799] Build status: STARTED
[13:43:41.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:99:0) after 2m32s
[13:46:13.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:99:0)
[13:46:13.828] Build status: STARTED
[13:46:13.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:100:0) after 1m48s
[13:48:01.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:100:0)
[13:48:01.893] Build status: STARTED
[13:48:01.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:101:0) after 6m37s
[13:54:38.990] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:101:0)
[13:54:39.019] Build status: STARTED
[13:54:39.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:102:0) after 7m0s
[14:01:39.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:102:0)
[14:01:39.194] Build status: STARTED
[14:01:39.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:103:0) after 5m34s
[14:07:13.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:103:0)
[14:07:13.401] Build status: STARTED
[14:07:13.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:104:0) after 9m57s
[14:17:10.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:104:0)
[14:17:10.475] Build status: STARTED
[14:17:10.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:105:0) after 5m41s
[14:22:51.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:105:0)
[14:22:51.651] Build status: STARTED
[14:22:51.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:106:0) after 4m57s
[14:27:48.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:106:0)
[14:27:48.755] Build status: STARTED
[14:27:48.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin:9001481111361037728:107:0) after 7m29s
[14:31:39.505] Received PubSub notification, asking Buildbucket for the build status
[14:31:39.542] Build:
{
"id": "8836051049313888785",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin"
},
"number": 381,
"createdBy": "project:chromium",
"createTime": "2021-09-15T05:01:18.022636578Z",
"startTime": "2021-09-15T05:54:51.087792Z",
"endTime": "2021-09-15T14:31:39.111250176Z",
"updateTime": "2021-09-15T14:31:39.111711925Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "88fbd48c6783e0602a46027edaf257a22b50251a",
"ref": "refs/heads/main"
}
}
}
[14:31:39.542] Invocation finished in 9h30m22.855333356s with status FAILED