[16:32:24.533] New invocation is queued and will start shortly
[16:32:25.932] Starting the invocation (attempt 1)
[16:32:25.961] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15856b93e920212a6875f7f58607dbc3090daef3"
[16:32:25.961] Popped gitiles commit info from properties and tags
[16:32:25.961] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:32:25.962] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:32:25.962] Buildbucket request:
{
"requestId": "8933671098319197664",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "15856b93e920212a6875f7f58607dbc3090daef3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8933671098319197664"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:32:26.832] Scheduled build:
{
"id": "8768241036018319969",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 31148,
"createdBy": "project:chromium",
"createTime": "2023-10-03T16:32:26.097588538Z",
"updateTime": "2023-10-03T16:32:26.097588538Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "15856b93e920212a6875f7f58607dbc3090daef3",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:32:26.832] Task URL: https://cr-buildbucket.appspot.com/build/8768241036018319969
[16:32:26.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:2:0) after 5m21s
[16:32:27.822] Received PubSub notification, asking Buildbucket for the build status
[16:32:27.847] Build status: SCHEDULED
[16:32:35.482] Received PubSub notification, asking Buildbucket for the build status
[16:32:35.499] Build status: STARTED
[16:37:47.930] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:2:0)
[16:37:47.992] Build status: STARTED
[16:37:47.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:5:0) after 9m7s
[16:46:55.007] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:5:0)
[16:46:55.025] Build status: STARTED
[16:46:55.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:6:0) after 1m52s
[16:48:47.064] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:6:0)
[16:48:47.085] Build status: STARTED
[16:48:47.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:7:0) after 9m1s
[16:57:48.227] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:7:0)
[16:57:48.247] Build status: STARTED
[16:57:48.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:8:0) after 5m1s
[17:02:49.424] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:8:0)
[17:02:49.442] Build status: STARTED
[17:02:49.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:9:0) after 3m38s
[17:06:27.461] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:9:0)
[17:06:27.483] Build status: STARTED
[17:06:27.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:10:0) after 3m37s
[17:10:05.054] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:10:0)
[17:10:05.076] Build status: STARTED
[17:10:05.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:11:0) after 7m13s
[17:17:18.071] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:11:0)
[17:17:18.120] Build status: STARTED
[17:17:18.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:12:0) after 3m53s
[17:21:11.143] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:12:0)
[17:21:11.170] Build status: STARTED
[17:21:11.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:13:0) after 8m11s
[17:29:22.198] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:13:0)
[17:29:22.235] Build status: STARTED
[17:29:22.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:14:0) after 5m30s
[17:34:52.256] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:14:0)
[17:34:52.305] Build status: STARTED
[17:34:52.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:15:0) after 9m9s
[17:44:01.364] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:15:0)
[17:44:01.395] Build status: STARTED
[17:44:01.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:16:0) after 7m0s
[17:51:01.438] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:16:0)
[17:51:01.465] Build status: STARTED
[17:51:01.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:17:0) after 2m30s
[17:53:31.516] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:17:0)
[17:53:31.537] Build status: STARTED
[17:53:31.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:18:0) after 8m30s
[18:02:02.320] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:18:0)
[18:02:02.356] Build status: STARTED
[18:02:02.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:19:0) after 9m35s
[18:11:37.375] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:19:0)
[18:11:37.397] Build status: STARTED
[18:11:37.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:20:0) after 3m11s
[18:14:48.500] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:20:0)
[18:14:48.517] Build status: STARTED
[18:14:48.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:21:0) after 1m2s
[18:15:50.496] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:21:0)
[18:15:50.512] Build status: STARTED
[18:15:50.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:22:0) after 3m24s
[18:19:15.975] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:22:0)
[18:19:16.068] Build status: STARTED
[18:19:16.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:23:0) after 1m53s
[18:21:09.112] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:23:0)
[18:21:09.135] Build status: STARTED
[18:21:09.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:24:0) after 4m3s
[18:25:12.566] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:24:0)
[18:25:12.622] Build status: STARTED
[18:25:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:25:0) after 7m5s
[18:32:17.926] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:25:0)
[18:32:17.948] Build status: STARTED
[18:32:17.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:26:0) after 4m20s
[18:36:38.002] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:26:0)
[18:36:38.132] Build status: STARTED
[18:36:38.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:27:0) after 6m16s
[18:42:54.157] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:27:0)
[18:42:54.174] Build status: STARTED
[18:42:54.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:28:0) after 8m55s
[18:51:49.197] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:28:0)
[18:51:49.223] Build status: STARTED
[18:51:49.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:29:0) after 1m34s
[18:53:23.241] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:29:0)
[18:53:23.262] Build status: STARTED
[18:53:23.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:30:0) after 3m50s
[18:57:14.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:30:0)
[18:57:14.107] Build status: STARTED
[18:57:14.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:31:0) after 7m30s
[19:04:44.739] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:31:0)
[19:04:44.758] Build status: STARTED
[19:04:44.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:32:0) after 2m4s
[19:06:48.872] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:32:0)
[19:06:48.892] Build status: STARTED
[19:06:48.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:33:0) after 6m59s
[19:13:48.220] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:33:0)
[19:13:48.243] Build status: STARTED
[19:13:48.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:34:0) after 8m21s
[19:22:09.321] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:34:0)
[19:22:09.350] Build status: STARTED
[19:22:09.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:35:0) after 1m38s
[19:23:47.359] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:35:0)
[19:23:47.382] Build status: STARTED
[19:23:47.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:36:0) after 1m40s
[19:25:27.651] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:36:0)
[19:25:27.676] Build status: STARTED
[19:25:27.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:37:0) after 2m51s
[19:28:18.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:37:0)
[19:28:18.772] Build status: STARTED
[19:28:18.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:38:0) after 9m38s
[19:37:56.887] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:38:0)
[19:37:56.911] Build status: STARTED
[19:37:56.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:39:0) after 1m58s
[19:39:55.008] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:39:0)
[19:39:55.095] Build status: STARTED
[19:39:55.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:40:0) after 6m34s
[19:46:29.229] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:40:0)
[19:46:29.263] Build status: STARTED
[19:46:29.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:41:0) after 4m9s
[19:50:38.560] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:41:0)
[19:50:38.634] Build status: STARTED
[19:50:38.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:42:0) after 3m52s
[19:54:31.224] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:42:0)
[19:54:31.247] Build status: STARTED
[19:54:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:43:0) after 1m39s
[19:56:10.283] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:43:0)
[19:56:10.304] Build status: STARTED
[19:56:10.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:44:0) after 6m16s
[20:02:26.320] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:44:0)
[20:02:26.337] Build status: STARTED
[20:02:26.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:45:0) after 4m16s
[20:06:42.336] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:45:0)
[20:06:42.357] Build status: STARTED
[20:06:42.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:46:0) after 4m8s
[20:10:50.451] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:46:0)
[20:10:50.474] Build status: STARTED
[20:10:50.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:47:0) after 7m45s
[20:18:35.494] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:47:0)
[20:18:35.541] Build status: STARTED
[20:18:35.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:48:0) after 2m46s
[20:21:21.826] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:48:0)
[20:21:21.848] Build status: STARTED
[20:21:21.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:49:0) after 9m57s
[20:31:18.892] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:49:0)
[20:31:18.989] Build status: STARTED
[20:31:18.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:50:0) after 4m24s
[20:35:43.234] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:50:0)
[20:35:43.273] Build status: STARTED
[20:35:43.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:51:0) after 1m3s
[20:36:46.515] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:51:0)
[20:36:46.669] Build status: STARTED
[20:36:46.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:52:0) after 9m34s
[20:46:20.684] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:52:0)
[20:46:20.708] Build status: STARTED
[20:46:20.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:53:0) after 3m27s
[20:49:47.851] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:53:0)
[20:49:47.868] Build status: STARTED
[20:49:47.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:54:0) after 9m58s
[20:59:46.117] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:54:0)
[20:59:46.201] Build status: STARTED
[20:59:46.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:55:0) after 9m35s
[21:09:21.574] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:55:0)
[21:09:21.594] Build status: STARTED
[21:09:21.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:56:0) after 8m52s
[21:18:13.836] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:56:0)
[21:18:13.856] Build status: STARTED
[21:18:13.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:57:0) after 3m23s
[21:21:37.173] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:57:0)
[21:21:37.390] Build status: STARTED
[21:21:37.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:58:0) after 2m7s
[21:23:44.804] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:58:0)
[21:23:44.831] Build status: STARTED
[21:23:44.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:59:0) after 4m20s
[21:28:05.217] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:59:0)
[21:28:05.256] Build status: STARTED
[21:28:05.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:60:0) after 8m5s
[21:36:10.322] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:60:0)
[21:36:10.370] Build status: STARTED
[21:36:10.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:61:0) after 3m59s
[21:40:09.438] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:61:0)
[21:40:09.457] Build status: STARTED
[21:40:09.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:62:0) after 5m59s
[21:46:08.637] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:62:0)
[21:46:08.726] Build status: STARTED
[21:46:08.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:63:0) after 5m32s
[21:51:40.752] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:63:0)
[21:51:40.781] Build status: STARTED
[21:51:40.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:64:0) after 1m53s
[21:53:34.165] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:64:0)
[21:53:34.200] Build status: STARTED
[21:53:34.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:65:0) after 9m10s
[22:02:44.217] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:65:0)
[22:02:44.272] Build status: STARTED
[22:02:44.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:66:0) after 1m53s
[22:04:37.344] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:66:0)
[22:04:37.443] Build status: STARTED
[22:04:37.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:67:0) after 1m58s
[22:06:35.479] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:67:0)
[22:06:35.528] Build status: STARTED
[22:06:35.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:68:0) after 4m20s
[22:10:55.515] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:68:0)
[22:10:55.537] Build status: STARTED
[22:10:55.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:69:0) after 9m21s
[22:20:16.565] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:69:0)
[22:20:16.889] Build status: STARTED
[22:20:16.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:70:0) after 2m59s
[22:23:15.921] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:70:0)
[22:23:15.948] Build status: STARTED
[22:23:15.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:71:0) after 8m38s
[22:31:54.033] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:71:0)
[22:31:54.053] Build status: STARTED
[22:31:54.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:72:0) after 3m25s
[22:35:19.257] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:72:0)
[22:35:19.279] Build status: STARTED
[22:35:19.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:73:0) after 1m28s
[22:36:47.427] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:73:0)
[22:36:47.446] Build status: STARTED
[22:36:47.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:74:0) after 9m50s
[22:46:37.539] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:74:0)
[22:46:37.560] Build status: STARTED
[22:46:37.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:75:0) after 5m13s
[22:51:50.599] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:75:0)
[22:51:50.617] Build status: STARTED
[22:51:50.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:76:0) after 6m12s
[22:58:02.793] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:76:0)
[22:58:02.810] Build status: STARTED
[22:58:02.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:77:0) after 3m29s
[23:01:32.034] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:77:0)
[23:01:32.055] Build status: STARTED
[23:01:32.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:78:0) after 9m35s
[23:11:07.374] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:78:0)
[23:11:07.392] Build status: STARTED
[23:11:07.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:79:0) after 7m52s
[23:18:59.498] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:79:0)
[23:18:59.579] Build status: STARTED
[23:18:59.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:80:0) after 5m37s
[23:24:36.668] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:80:0)
[23:24:36.710] Build status: STARTED
[23:24:36.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:81:0) after 6m12s
[23:30:49.014] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:81:0)
[23:30:49.034] Build status: STARTED
[23:30:49.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:82:0) after 1m13s
[23:32:02.318] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:82:0)
[23:32:02.343] Build status: STARTED
[23:32:02.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:83:0) after 1m33s
[23:33:35.376] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:83:0)
[23:33:35.401] Build status: STARTED
[23:33:35.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:84:0) after 8m3s
[23:41:38.432] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:84:0)
[23:41:38.531] Build status: STARTED
[23:41:38.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:85:0) after 2m15s
[23:43:53.548] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:85:0)
[23:43:53.569] Build status: STARTED
[23:43:53.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:86:0) after 4m22s
[23:48:15.596] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:86:0)
[23:48:15.621] Build status: STARTED
[23:48:15.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:87:0) after 6m29s
[23:54:45.062] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:87:0)
[23:54:45.133] Build status: STARTED
[23:54:45.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:88:0) after 5m35s
[00:00:20.267] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:88:0)
[00:00:20.312] Build status: STARTED
[00:00:20.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:89:0) after 7m7s
[00:07:27.356] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:89:0)
[00:07:27.377] Build status: STARTED
[00:07:27.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:90:0) after 4m1s
[00:11:28.548] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:90:0)
[00:11:28.572] Build status: STARTED
[00:11:28.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:91:0) after 3m12s
[00:14:40.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:91:0)
[00:14:40.795] Build status: STARTED
[00:14:40.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:92:0) after 8m11s
[00:22:52.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:92:0)
[00:22:52.087] Build status: STARTED
[00:22:52.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:93:0) after 8m57s
[00:31:49.464] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:93:0)
[00:31:49.482] Build status: STARTED
[00:31:49.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:94:0) after 7m10s
[00:38:59.501] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:94:0)
[00:38:59.520] Build status: STARTED
[00:38:59.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:95:0) after 8m39s
[00:47:38.546] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:95:0)
[00:47:38.566] Build status: STARTED
[00:47:38.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:96:0) after 9m10s
[00:56:48.589] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:96:0)
[00:56:48.642] Build status: STARTED
[00:56:48.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:97:0) after 9m5s
[01:05:53.847] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:97:0)
[01:05:53.872] Build status: STARTED
[01:05:53.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:98:0) after 8m36s
[01:14:29.906] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:98:0)
[01:14:29.921] Build status: STARTED
[01:14:29.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:99:0) after 6m36s
[01:21:06.416] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:99:0)
[01:21:06.437] Build status: STARTED
[01:21:06.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:100:0) after 1m1s
[01:22:07.420] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:100:0)
[01:22:07.479] Build status: STARTED
[01:22:07.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:101:0) after 9m41s
[01:31:48.862] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:101:0)
[01:31:48.888] Build status: STARTED
[01:31:48.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:102:0) after 5m21s
[01:37:09.909] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:102:0)
[01:37:09.932] Build status: STARTED
[01:37:09.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:103:0) after 3m21s
[01:40:31.052] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:103:0)
[01:40:31.139] Build status: STARTED
[01:40:31.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:104:0) after 2m11s
[01:42:42.157] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:104:0)
[01:42:42.182] Build status: STARTED
[01:42:42.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:105:0) after 8m35s
[01:51:17.202] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:105:0)
[01:51:17.221] Build status: STARTED
[01:51:17.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:106:0) after 9m16s
[02:00:33.358] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:106:0)
[02:00:33.380] Build status: STARTED
[02:00:33.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:107:0) after 9m40s
[02:10:13.559] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:107:0)
[02:10:13.588] Build status: STARTED
[02:10:13.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:108:0) after 3m1s
[02:13:14.833] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:108:0)
[02:13:14.921] Build status: STARTED
[02:13:14.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:109:0) after 8m37s
[02:21:52.014] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:109:0)
[02:21:52.035] Build status: STARTED
[02:21:52.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:110:0) after 2m30s
[02:24:22.060] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:110:0)
[02:24:22.132] Build status: STARTED
[02:24:22.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:111:0) after 1m19s
[02:25:41.311] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:111:0)
[02:25:41.336] Build status: STARTED
[02:25:41.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:112:0) after 3m8s
[02:28:49.413] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:112:0)
[02:28:49.438] Build status: STARTED
[02:28:49.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:113:0) after 2m36s
[02:31:25.460] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:113:0)
[02:31:25.480] Build status: STARTED
[02:31:25.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:114:0) after 2m59s
[02:34:24.665] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:114:0)
[02:34:24.695] Build status: STARTED
[02:34:24.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:115:0) after 1m3s
[02:35:27.876] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:115:0)
[02:35:27.897] Build status: STARTED
[02:35:27.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:116:0) after 5m38s
[02:41:06.015] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:116:0)
[02:41:06.093] Build status: STARTED
[02:41:06.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:117:0) after 8m56s
[02:50:02.115] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:117:0)
[02:50:02.137] Build status: STARTED
[02:50:02.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:118:0) after 3m4s
[02:53:06.172] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:118:0)
[02:53:06.196] Build status: STARTED
[02:53:06.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:119:0) after 5m8s
[02:58:14.230] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:119:0)
[02:58:14.348] Build status: STARTED
[02:58:14.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:120:0) after 1m45s
[02:59:59.655] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:120:0)
[02:59:59.677] Build status: STARTED
[02:59:59.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:121:0) after 5m17s
[03:05:16.798] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:121:0)
[03:05:16.818] Build status: STARTED
[03:05:16.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:122:0) after 1m47s
[03:07:03.929] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:122:0)
[03:07:03.950] Build status: STARTED
[03:07:03.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:123:0) after 9m27s
[03:16:31.203] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:123:0)
[03:16:31.233] Build status: STARTED
[03:16:31.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:124:0) after 7m15s
[03:23:46.351] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:124:0)
[03:23:46.407] Build status: STARTED
[03:23:46.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:125:0) after 6m10s
[03:29:56.580] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:125:0)
[03:29:56.601] Build status: STARTED
[03:29:56.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:126:0) after 2m42s
[03:32:38.633] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:126:0)
[03:32:38.657] Build status: STARTED
[03:32:38.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:127:0) after 9m24s
[03:42:02.674] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:127:0)
[03:42:02.697] Build status: STARTED
[03:42:02.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:128:0) after 7m8s
[03:49:11.062] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:128:0)
[03:49:11.079] Build status: STARTED
[03:49:11.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:129:0) after 6m44s
[03:55:55.253] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:129:0)
[03:55:55.271] Build status: STARTED
[03:55:55.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:130:0) after 5m26s
[04:01:21.260] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:130:0)
[04:01:21.326] Build status: STARTED
[04:01:21.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:131:0) after 5m41s
[04:07:03.145] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:131:0)
[04:07:03.181] Build status: STARTED
[04:07:03.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:132:0) after 5m1s
[04:12:04.201] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:132:0)
[04:12:04.219] Build status: STARTED
[04:12:04.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:133:0) after 3m17s
[04:15:21.320] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:133:0)
[04:15:21.340] Build status: STARTED
[04:15:21.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:134:0) after 6m19s
[04:21:40.437] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:134:0)
[04:21:40.456] Build status: STARTED
[04:21:40.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:135:0) after 3m54s
[04:25:34.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:135:0)
[04:25:34.630] Build status: STARTED
[04:25:34.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:136:0) after 1m12s
[04:26:46.650] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:136:0)
[04:26:46.669] Build status: STARTED
[04:26:46.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:137:0) after 3m29s
[04:30:15.705] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:137:0)
[04:30:15.825] Build status: STARTED
[04:30:15.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:138:0) after 4m31s
[04:34:47.496] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:138:0)
[04:34:47.611] Build status: STARTED
[04:34:47.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:139:0) after 1m18s
[04:36:06.160] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:139:0)
[04:36:06.189] Build status: STARTED
[04:36:06.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:140:0) after 4m50s
[04:40:56.223] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:140:0)
[04:40:56.251] Build status: STARTED
[04:40:56.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:141:0) after 9m30s
[04:50:26.272] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:141:0)
[04:50:26.296] Build status: STARTED
[04:50:26.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:142:0) after 1m18s
[04:51:44.322] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:142:0)
[04:51:44.345] Build status: STARTED
[04:51:44.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:143:0) after 6m3s
[04:57:47.441] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:143:0)
[04:57:47.463] Build status: STARTED
[04:57:47.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:144:0) after 8m36s
[05:06:23.544] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:144:0)
[05:06:23.572] Build status: STARTED
[05:06:23.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:145:0) after 4m37s
[05:11:00.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:145:0)
[05:11:00.838] Build status: STARTED
[05:11:00.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:146:0) after 2m27s
[05:13:27.921] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:146:0)
[05:13:27.939] Build status: STARTED
[05:13:27.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:147:0) after 8m1s
[05:21:29.346] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:147:0)
[05:21:29.368] Build status: STARTED
[05:21:29.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:148:0) after 2m17s
[05:23:46.529] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:148:0)
[05:23:46.572] Build status: STARTED
[05:23:46.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:149:0) after 5m22s
[05:29:08.695] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:149:0)
[05:29:08.740] Build status: STARTED
[05:29:08.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:150:0) after 1m21s
[05:30:29.723] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:150:0)
[05:30:29.746] Build status: STARTED
[05:30:29.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:151:0) after 2m23s
[05:32:52.799] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:151:0)
[05:32:52.817] Build status: STARTED
[05:32:52.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:152:0) after 6m47s
[05:39:39.934] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:152:0)
[05:39:40.038] Build status: STARTED
[05:39:40.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:153:0) after 1m35s
[05:41:15.407] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:153:0)
[05:41:15.430] Build status: STARTED
[05:41:15.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:154:0) after 5m51s
[05:47:06.685] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:154:0)
[05:47:06.701] Build status: STARTED
[05:47:06.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:155:0) after 9m0s
[05:56:06.816] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:155:0)
[05:56:06.834] Build status: STARTED
[05:56:06.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:156:0) after 6m31s
[06:02:37.858] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:156:0)
[06:02:37.884] Build status: STARTED
[06:02:37.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:157:0) after 2m21s
[06:04:59.751] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:157:0)
[06:04:59.768] Build status: STARTED
[06:04:59.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:158:0) after 3m33s
[06:08:32.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:158:0)
[06:08:32.919] Build status: STARTED
[06:08:32.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:159:0) after 6m28s
[06:15:00.961] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:159:0)
[06:15:01.018] Build status: STARTED
[06:15:01.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:160:0) after 7m18s
[06:22:19.090] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:160:0)
[06:22:19.106] Build status: STARTED
[06:22:19.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:161:0) after 4m22s
[06:26:41.228] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:161:0)
[06:26:41.293] Build status: STARTED
[06:26:41.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:162:0) after 6m35s
[06:33:16.425] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:162:0)
[06:33:16.444] Build status: STARTED
[06:33:16.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:163:0) after 3m55s
[06:37:11.594] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:163:0)
[06:37:11.610] Build status: STARTED
[06:37:11.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:164:0) after 2m55s
[06:40:06.736] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:164:0)
[06:40:06.759] Build status: STARTED
[06:40:06.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:165:0) after 4m37s
[06:44:44.183] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:165:0)
[06:44:44.204] Build status: STARTED
[06:44:44.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:166:0) after 2m38s
[06:47:22.245] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:166:0)
[06:47:22.284] Build status: STARTED
[06:47:22.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:167:0) after 5m48s
[06:53:10.416] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:167:0)
[06:53:10.434] Build status: STARTED
[06:53:10.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:168:0) after 3m43s
[06:56:53.456] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:168:0)
[06:56:53.480] Build status: STARTED
[06:56:53.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:169:0) after 2m57s
[06:59:50.562] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:169:0)
[06:59:50.581] Build status: STARTED
[06:59:50.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:170:0) after 7m22s
[07:07:12.839] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:170:0)
[07:07:13.050] Build status: STARTED
[07:07:13.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:171:0) after 4m49s
[07:12:02.297] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:171:0)
[07:12:02.400] Build status: STARTED
[07:12:02.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:172:0) after 8m25s
[07:20:27.463] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:172:0)
[07:20:27.487] Build status: STARTED
[07:20:27.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:173:0) after 1m47s
[07:22:14.628] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:173:0)
[07:22:14.648] Build status: STARTED
[07:22:14.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:174:0) after 2m46s
[07:25:00.972] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:174:0)
[07:25:01.192] Build status: STARTED
[07:25:01.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:175:0) after 6m55s
[07:31:56.427] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:175:0)
[07:31:56.448] Build status: STARTED
[07:31:56.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:176:0) after 3m13s
[07:35:09.749] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:176:0)
[07:35:09.832] Build status: STARTED
[07:35:09.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:177:0) after 8m56s
[07:44:05.879] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:177:0)
[07:44:06.066] Build status: STARTED
[07:44:06.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:178:0) after 5m32s
[07:49:38.086] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:178:0)
[07:49:38.104] Build status: STARTED
[07:49:38.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:179:0) after 4m49s
[07:54:27.201] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:179:0)
[07:54:27.224] Build status: STARTED
[07:54:27.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:180:0) after 1m56s
[07:56:23.316] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:180:0)
[07:56:23.336] Build status: STARTED
[07:56:23.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:181:0) after 7m42s
[08:04:05.355] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:181:0)
[08:04:05.388] Build status: STARTED
[08:04:05.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:182:0) after 5m23s
[08:09:28.508] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:182:0)
[08:09:28.562] Build status: STARTED
[08:09:28.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:183:0) after 4m7s
[08:13:35.732] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:183:0)
[08:13:35.752] Build status: STARTED
[08:13:35.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:184:0) after 4m5s
[08:17:41.039] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:184:0)
[08:17:41.058] Build status: STARTED
[08:17:41.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:185:0) after 9m40s
[08:27:21.322] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:185:0)
[08:27:21.347] Build status: STARTED
[08:27:21.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:186:0) after 3m42s
[08:31:03.420] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:186:0)
[08:31:03.479] Build status: STARTED
[08:31:03.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:187:0) after 5m27s
[08:36:30.518] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:187:0)
[08:36:30.542] Build status: STARTED
[08:36:30.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:188:0) after 5m14s
[08:41:44.827] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:188:0)
[08:41:44.844] Build status: STARTED
[08:41:44.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:189:0) after 2m57s
[08:44:42.382] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:189:0)
[08:44:42.398] Build status: STARTED
[08:44:42.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:190:0) after 7m5s
[08:51:47.453] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:190:0)
[08:51:47.469] Build status: STARTED
[08:51:47.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:191:0) after 5m51s
[08:57:38.558] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:191:0)
[08:57:38.580] Build status: STARTED
[08:57:38.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:192:0) after 1m40s
[08:59:18.599] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:192:0)
[08:59:18.619] Build status: STARTED
[08:59:18.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:193:0) after 6m43s
[09:06:01.721] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:193:0)
[09:06:01.756] Build status: STARTED
[09:06:01.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:194:0) after 3m14s
[09:09:15.771] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:194:0)
[09:09:15.810] Build status: STARTED
[09:09:15.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:195:0) after 6m26s
[09:15:42.057] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:195:0)
[09:15:42.076] Build status: STARTED
[09:15:42.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:196:0) after 1m13s
[09:16:55.096] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:196:0)
[09:16:55.125] Build status: STARTED
[09:16:55.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:197:0) after 9m17s
[09:26:12.372] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:197:0)
[09:26:12.502] Build status: STARTED
[09:26:12.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:198:0) after 9m46s
[09:35:58.779] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:198:0)
[09:35:58.803] Build status: STARTED
[09:35:58.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:199:0) after 7m52s
[09:43:51.378] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:199:0)
[09:43:51.396] Build status: STARTED
[09:43:51.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:200:0) after 9m20s
[09:53:11.885] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:200:0)
[09:53:11.912] Build status: STARTED
[09:53:11.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:201:0) after 7m3s
[10:00:14.933] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:201:0)
[10:00:15.005] Build status: STARTED
[10:00:15.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:202:0) after 4m40s
[10:04:55.047] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:202:0)
[10:04:55.071] Build status: STARTED
[10:04:55.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:203:0) after 5m35s
[10:10:30.246] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:203:0)
[10:10:30.267] Build status: STARTED
[10:10:30.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:204:0) after 6m8s
[10:16:38.288] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:204:0)
[10:16:38.386] Build status: STARTED
[10:16:38.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:205:0) after 8m14s
[10:24:52.514] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:205:0)
[10:24:52.540] Build status: STARTED
[10:24:52.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8933671098319197664:206:0) after 6m8s
[10:25:39.808] Received PubSub notification, asking Buildbucket for the build status
[10:25:39.825] Build:
{
"id": "8768241036018319969",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 31148,
"createdBy": "project:chromium",
"createTime": "2023-10-03T16:32:26.097588538Z",
"startTime": "2023-10-03T16:32:34.973009Z",
"endTime": "2023-10-04T10:25:39.485502631Z",
"updateTime": "2023-10-04T10:25:39.485502631Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "15856b93e920212a6875f7f58607dbc3090daef3",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:25:39.825] Invocation finished in 17h53m15.305612119s with status FAILED