[15:52:54.416] New invocation is queued and will start shortly
[15:52:55.507] Starting the invocation (attempt 1)
[15:52:55.550] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d8148323e9703bfbc5500cb3354ccad1e0064df"
[15:52:55.550] Popped gitiles commit info from properties and tags
[15:52:55.550] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:52:55.551] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:52:55.551] Buildbucket request:
{
"requestId": "8977522515313330032",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5d8148323e9703bfbc5500cb3354ccad1e0064df",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8977522515313330032"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:52:56.655] Scheduled build:
{
"id": "8812092453368400433",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 27911,
"createdBy": "project:chromium",
"createTime": "2022-06-06T15:52:55.633109867Z",
"updateTime": "2022-06-06T15:52:55.633109867Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5d8148323e9703bfbc5500cb3354ccad1e0064df",
"ref": "refs/heads/main"
}
}
}
[15:52:56.655] Task URL: https://cr-buildbucket.appspot.com/build/8812092453368400433
[15:52:56.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:2:0) after 7m7s
[16:00:03.728] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:2:0)
[16:00:03.763] Build status: SCHEDULED
[16:00:03.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:3:0) after 7m22s
[16:07:25.783] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:3:0)
[16:07:25.803] Build status: SCHEDULED
[16:07:25.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:4:0) after 7m20s
[16:14:45.849] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:4:0)
[16:14:45.870] Build status: SCHEDULED
[16:14:45.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:5:0) after 5m59s
[16:20:44.897] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:5:0)
[16:20:44.950] Build status: SCHEDULED
[16:20:44.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:6:0) after 8m20s
[16:29:05.146] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:6:0)
[16:29:07.052] Build status: SCHEDULED
[16:29:07.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:7:0) after 8m28s
[16:37:35.085] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:7:0)
[16:37:35.117] Build status: SCHEDULED
[16:37:35.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:8:0) after 9m48s
[16:41:25.505] Received PubSub notification, asking Buildbucket for the build status
[16:41:25.571] Build status: STARTED
[16:47:23.204] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:8:0)
[16:47:23.277] Build status: STARTED
[16:47:23.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:10:0) after 7m58s
[16:55:21.298] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:10:0)
[16:55:21.320] Build status: STARTED
[16:55:21.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:11:0) after 1m51s
[16:57:12.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:11:0)
[16:57:12.738] Build status: STARTED
[16:57:12.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:12:0) after 9m55s
[17:07:07.868] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:12:0)
[17:07:07.910] Build status: STARTED
[17:07:07.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:13:0) after 3m28s
[17:10:36.182] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:13:0)
[17:10:36.214] Build status: STARTED
[17:10:36.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:14:0) after 7m4s
[17:17:40.609] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:14:0)
[17:17:40.632] Build status: STARTED
[17:17:40.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:15:0) after 2m13s
[17:19:53.651] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:15:0)
[17:19:53.673] Build status: STARTED
[17:19:53.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:16:0) after 3m56s
[17:23:49.798] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:16:0)
[17:23:49.828] Build status: STARTED
[17:23:49.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:17:0) after 2m46s
[17:26:35.953] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:17:0)
[17:26:35.976] Build status: STARTED
[17:26:35.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:18:0) after 9m10s
[17:35:46.398] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:18:0)
[17:35:46.429] Build status: STARTED
[17:35:46.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:19:0) after 1m43s
[17:37:29.456] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:19:0)
[17:37:29.491] Build status: STARTED
[17:37:29.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:20:0) after 3m25s
[17:40:54.628] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:20:0)
[17:40:54.650] Build status: STARTED
[17:40:54.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:21:0) after 5m4s
[17:45:58.749] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:21:0)
[17:45:58.810] Build status: STARTED
[17:45:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:22:0) after 3m56s
[17:49:55.377] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:22:0)
[17:49:55.407] Build status: STARTED
[17:49:55.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:23:0) after 8m39s
[17:58:34.672] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:23:0)
[17:58:34.744] Build status: STARTED
[17:58:34.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:24:0) after 3m37s
[18:02:11.771] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:24:0)
[18:02:11.809] Build status: STARTED
[18:02:11.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:25:0) after 3m49s
[18:06:01.246] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:25:0)
[18:06:01.301] Build status: STARTED
[18:06:01.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:26:0) after 2m55s
[18:08:56.382] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:26:0)
[18:08:56.403] Build status: STARTED
[18:08:56.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:27:0) after 6m23s
[18:15:19.614] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:27:0)
[18:15:19.633] Build status: STARTED
[18:15:19.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:28:0) after 3m6s
[18:18:25.662] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:28:0)
[18:18:25.688] Build status: STARTED
[18:18:25.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:29:0) after 5m10s
[18:23:35.854] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:29:0)
[18:23:35.935] Build status: STARTED
[18:23:35.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:30:0) after 5m28s
[18:29:04.130] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:30:0)
[18:29:04.163] Build status: STARTED
[18:29:04.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:31:0) after 3m10s
[18:32:14.401] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:31:0)
[18:32:14.449] Build status: STARTED
[18:32:14.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:32:0) after 4m0s
[18:36:14.872] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:32:0)
[18:36:14.922] Build status: STARTED
[18:36:14.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:33:0) after 2m8s
[18:38:23.075] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:33:0)
[18:38:23.108] Build status: STARTED
[18:38:23.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:34:0) after 3m16s
[18:41:39.480] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:34:0)
[18:41:40.856] Build status: STARTED
[18:41:40.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:35:0) after 8m54s
[18:50:34.891] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:35:0)
[18:50:34.922] Build status: STARTED
[18:50:34.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:36:0) after 5m35s
[18:56:10.073] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:36:0)
[18:56:10.104] Build status: STARTED
[18:56:10.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:37:0) after 6m55s
[19:03:05.280] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:37:0)
[19:03:05.308] Build status: STARTED
[19:03:05.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:38:0) after 2m48s
[19:05:53.876] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:38:0)
[19:05:53.937] Build status: STARTED
[19:05:53.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:39:0) after 4m28s
[19:10:22.161] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:39:0)
[19:10:22.185] Build status: STARTED
[19:10:22.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:40:0) after 4m35s
[19:14:57.312] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:40:0)
[19:14:57.335] Build status: STARTED
[19:14:57.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:41:0) after 4m4s
[19:19:01.404] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:41:0)
[19:19:01.425] Build status: STARTED
[19:19:01.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:42:0) after 9m5s
[19:28:06.459] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:42:0)
[19:28:06.499] Build status: STARTED
[19:28:06.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:43:0) after 4m23s
[19:32:29.686] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:43:0)
[19:32:29.710] Build status: STARTED
[19:32:29.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:44:0) after 2m50s
[19:35:20.281] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:44:0)
[19:35:20.304] Build status: STARTED
[19:35:20.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:45:0) after 7m8s
[19:42:28.409] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:45:0)
[19:42:28.430] Build status: STARTED
[19:42:28.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:46:0) after 8m7s
[19:50:35.523] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:46:0)
[19:50:35.546] Build status: STARTED
[19:50:35.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:47:0) after 5m13s
[19:55:48.569] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:47:0)
[19:55:48.593] Build status: STARTED
[19:55:48.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:48:0) after 7m32s
[20:03:20.796] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:48:0)
[20:03:20.841] Build status: STARTED
[20:03:20.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:49:0) after 2m7s
[20:05:28.038] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:49:0)
[20:05:28.062] Build status: STARTED
[20:05:28.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:50:0) after 6m0s
[20:11:28.082] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:50:0)
[20:11:28.116] Build status: STARTED
[20:11:28.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:51:0) after 4m54s
[20:16:22.187] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:51:0)
[20:16:22.235] Build status: STARTED
[20:16:22.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:52:0) after 2m9s
[20:18:31.283] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:52:0)
[20:18:31.325] Build status: STARTED
[20:18:31.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:53:0) after 6m22s
[20:24:53.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:53:0)
[20:24:53.923] Build status: STARTED
[20:24:53.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:54:0) after 3m13s
[20:28:07.604] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:54:0)
[20:28:07.629] Build status: STARTED
[20:28:07.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:55:0) after 2m33s
[20:30:40.654] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:55:0)
[20:30:40.682] Build status: STARTED
[20:30:40.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:56:0) after 3m0s
[20:33:41.007] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:56:0)
[20:33:41.081] Build status: STARTED
[20:33:41.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:57:0) after 8m44s
[20:42:25.110] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:57:0)
[20:42:25.134] Build status: STARTED
[20:42:25.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:58:0) after 5m26s
[20:47:51.160] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:58:0)
[20:47:51.200] Build status: STARTED
[20:47:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:59:0) after 8m37s
[20:56:28.223] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:59:0)
[20:56:28.269] Build status: STARTED
[20:56:28.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:60:0) after 7m30s
[21:03:58.545] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:60:0)
[21:03:58.585] Build status: STARTED
[21:03:58.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:61:0) after 7m35s
[21:11:33.771] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:61:0)
[21:11:33.923] Build status: STARTED
[21:11:33.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:62:0) after 7m28s
[21:19:02.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:62:0)
[21:19:02.120] Build status: STARTED
[21:19:02.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:63:0) after 5m17s
[21:24:19.195] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:63:0)
[21:24:19.229] Build status: STARTED
[21:24:19.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:64:0) after 7m20s
[21:31:40.620] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:64:0)
[21:31:40.837] Build status: STARTED
[21:31:40.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:65:0) after 2m11s
[21:33:52.608] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:65:0)
[21:33:52.634] Build status: STARTED
[21:33:52.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:66:0) after 3m6s
[21:36:58.655] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:66:0)
[21:36:58.681] Build status: STARTED
[21:36:58.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:67:0) after 6m5s
[21:43:03.704] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:67:0)
[21:43:03.726] Build status: STARTED
[21:43:03.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:68:0) after 3m56s
[21:46:59.753] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:68:0)
[21:46:59.792] Build status: STARTED
[21:46:59.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:69:0) after 2m32s
[21:49:32.197] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:69:0)
[21:49:32.238] Build status: STARTED
[21:49:32.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:70:0) after 2m21s
[21:51:53.265] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:70:0)
[21:51:53.306] Build status: STARTED
[21:51:53.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:71:0) after 1m8s
[21:53:01.286] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:71:0)
[21:53:01.311] Build status: STARTED
[21:53:01.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:72:0) after 2m38s
[21:55:39.360] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:72:0)
[21:55:39.397] Build status: STARTED
[21:55:39.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:73:0) after 4m27s
[22:00:06.541] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:73:0)
[22:00:06.566] Build status: STARTED
[22:00:06.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:74:0) after 5m45s
[22:05:51.781] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:74:0)
[22:05:51.844] Build status: STARTED
[22:05:51.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:75:0) after 4m2s
[22:09:53.875] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:75:0)
[22:09:53.909] Build status: STARTED
[22:09:53.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:76:0) after 3m1s
[22:12:55.024] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:76:0)
[22:12:55.047] Build status: STARTED
[22:12:55.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:77:0) after 4m12s
[22:17:07.655] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:77:0)
[22:17:07.690] Build status: STARTED
[22:17:07.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:78:0) after 4m49s
[22:21:56.822] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:78:0)
[22:21:56.845] Build status: STARTED
[22:21:56.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:79:0) after 5m21s
[22:27:17.984] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:79:0)
[22:27:18.040] Build status: STARTED
[22:27:18.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:80:0) after 3m58s
[22:31:16.106] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:80:0)
[22:31:16.144] Build status: STARTED
[22:31:16.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:81:0) after 3m35s
[22:34:51.215] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:81:0)
[22:34:51.244] Build status: STARTED
[22:34:51.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:82:0) after 3m45s
[22:38:36.277] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:82:0)
[22:38:36.342] Build status: STARTED
[22:38:36.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:83:0) after 9m7s
[22:47:43.607] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:83:0)
[22:47:43.629] Build status: STARTED
[22:47:43.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:84:0) after 2m23s
[22:50:06.876] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:84:0)
[22:50:06.899] Build status: STARTED
[22:50:06.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:85:0) after 9m53s
[23:00:00.018] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:85:0)
[23:00:00.040] Build status: STARTED
[23:00:00.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:86:0) after 3m10s
[23:03:10.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:86:0)
[23:03:10.098] Build status: STARTED
[23:03:10.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:87:0) after 3m59s
[23:07:09.298] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:87:0)
[23:07:09.330] Build status: STARTED
[23:07:09.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:88:0) after 8m20s
[23:15:29.543] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:88:0)
[23:15:29.636] Build status: STARTED
[23:15:29.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:89:0) after 8m31s
[23:24:00.662] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:89:0)
[23:24:00.730] Build status: STARTED
[23:24:00.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:90:0) after 9m29s
[23:33:29.788] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:90:0)
[23:33:29.820] Build status: STARTED
[23:33:29.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:91:0) after 6m15s
[23:39:44.860] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:91:0)
[23:39:44.882] Build status: STARTED
[23:39:44.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:92:0) after 4m36s
[23:44:20.998] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:92:0)
[23:44:21.035] Build status: STARTED
[23:44:21.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:93:0) after 3m2s
[23:47:23.063] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:93:0)
[23:47:23.096] Build status: STARTED
[23:47:23.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:94:0) after 5m17s
[23:52:40.132] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:94:0)
[23:52:40.170] Build status: STARTED
[23:52:40.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:95:0) after 5m49s
[23:58:29.250] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:95:0)
[23:58:29.274] Build status: STARTED
[23:58:29.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:96:0) after 1m2s
[23:59:31.669] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:96:0)
[23:59:31.705] Build status: STARTED
[23:59:31.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:97:0) after 9m47s
[00:09:18.740] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:97:0)
[00:09:18.769] Build status: STARTED
[00:09:18.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:98:0) after 5m52s
[00:15:10.946] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:98:0)
[00:15:11.030] Build status: STARTED
[00:15:11.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:99:0) after 9m17s
[00:24:28.163] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:99:0)
[00:24:28.203] Build status: STARTED
[00:24:28.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:100:0) after 4m59s
[00:29:27.343] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:100:0)
[00:29:27.380] Build status: STARTED
[00:29:27.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:101:0) after 9m36s
[00:39:03.845] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:101:0)
[00:39:03.889] Build status: STARTED
[00:39:03.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:102:0) after 8m40s
[00:47:44.173] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:102:0)
[00:47:44.201] Build status: STARTED
[00:47:44.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:103:0) after 8m40s
[00:56:24.517] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:103:0)
[00:56:24.542] Build status: STARTED
[00:56:24.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:104:0) after 3m53s
[01:00:17.568] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:104:0)
[01:00:17.606] Build status: STARTED
[01:00:17.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:105:0) after 4m26s
[01:04:43.729] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:105:0)
[01:04:43.754] Build status: STARTED
[01:04:43.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:106:0) after 4m31s
[01:09:14.783] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:106:0)
[01:09:14.810] Build status: STARTED
[01:09:14.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:107:0) after 3m27s
[01:12:41.968] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:107:0)
[01:12:41.992] Build status: STARTED
[01:12:41.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:108:0) after 4m19s
[01:17:01.159] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:108:0)
[01:17:01.183] Build status: STARTED
[01:17:01.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:109:0) after 3m29s
[01:20:30.209] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:109:0)
[01:20:30.232] Build status: STARTED
[01:20:30.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:110:0) after 8m39s
[01:29:09.376] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:110:0)
[01:29:09.413] Build status: STARTED
[01:29:09.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:111:0) after 5m44s
[01:34:53.652] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:111:0)
[01:34:53.672] Build status: STARTED
[01:34:53.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:112:0) after 4m14s
[01:39:08.078] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:112:0)
[01:39:08.122] Build status: STARTED
[01:39:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:113:0) after 9m40s
[01:48:48.162] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:113:0)
[01:48:48.185] Build status: STARTED
[01:48:48.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:114:0) after 5m40s
[01:54:28.212] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:114:0)
[01:54:28.232] Build status: STARTED
[01:54:28.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:115:0) after 2m43s
[01:57:11.370] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:115:0)
[01:57:11.401] Build status: STARTED
[01:57:11.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:116:0) after 1m34s
[01:58:46.165] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:116:0)
[01:58:46.188] Build status: STARTED
[01:58:46.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:117:0) after 9m37s
[02:08:23.245] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:117:0)
[02:08:23.281] Build status: STARTED
[02:08:23.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:118:0) after 9m54s
[02:18:17.488] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:118:0)
[02:18:17.521] Build status: STARTED
[02:18:17.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:119:0) after 5m36s
[02:23:53.695] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:119:0)
[02:23:53.715] Build status: STARTED
[02:23:53.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:120:0) after 3m44s
[02:27:37.864] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:120:0)
[02:27:37.888] Build status: STARTED
[02:27:37.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:121:0) after 8m25s
[02:36:03.279] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:121:0)
[02:36:03.300] Build status: STARTED
[02:36:03.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:122:0) after 9m33s
[02:45:36.427] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:122:0)
[02:45:36.464] Build status: STARTED
[02:45:36.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:123:0) after 2m31s
[02:48:07.495] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:123:0)
[02:48:07.532] Build status: STARTED
[02:48:07.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:124:0) after 1m57s
[02:50:04.565] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:124:0)
[02:50:04.586] Build status: STARTED
[02:50:04.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:125:0) after 4m53s
[02:54:57.612] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:125:0)
[02:54:57.637] Build status: STARTED
[02:54:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:126:0) after 2m38s
[02:57:35.664] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:126:0)
[02:57:35.747] Build status: STARTED
[02:57:35.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:127:0) after 7m19s
[03:04:54.964] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:127:0)
[03:04:54.986] Build status: STARTED
[03:04:54.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:128:0) after 8m54s
[03:13:49.012] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:128:0)
[03:13:49.035] Build status: STARTED
[03:13:49.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:129:0) after 5m45s
[03:19:34.287] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:129:0)
[03:19:34.320] Build status: STARTED
[03:19:34.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:130:0) after 1m59s
[03:21:33.346] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:130:0)
[03:21:33.369] Build status: STARTED
[03:21:33.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:131:0) after 7m30s
[03:29:03.399] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:131:0)
[03:29:03.423] Build status: STARTED
[03:29:03.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:132:0) after 5m49s
[03:34:52.541] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:132:0)
[03:34:52.567] Build status: STARTED
[03:34:52.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8977522515313330032:133:0) after 7m51s
[03:40:02.967] Received PubSub notification, asking Buildbucket for the build status
[03:40:03.031] Build:
{
"id": "8812092453368400433",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 27911,
"createdBy": "project:chromium",
"createTime": "2022-06-06T15:52:55.633109867Z",
"startTime": "2022-06-06T16:41:23.404084Z",
"endTime": "2022-06-07T03:40:02.400570085Z",
"updateTime": "2022-06-07T03:40:02.400570085Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5d8148323e9703bfbc5500cb3354ccad1e0064df",
"ref": "refs/heads/main"
}
}
}
[03:40:03.031] Invocation finished in 11h47m8.637607654s with status FAILED