[10:44:10.963] New invocation is queued and will start shortly
[10:44:12.669] Starting the invocation (attempt 1)
[10:44:12.700] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/125b9b9c1025997970c1b9ff053df5b835f179a1"
[10:44:12.700] Popped gitiles commit info from properties and tags
[10:44:12.700] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:44:12.700] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:44:12.700] Buildbucket request:
{
"requestId": "8928619576690539392",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "125b9b9c1025997970c1b9ff053df5b835f179a1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928619576690539392"
},
{
"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"
}
}
[10:44:13.316] Scheduled build:
{
"id": "8763189514140977025",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 31391,
"createdBy": "project:chromium",
"createTime": "2023-11-28T10:44:12.771363903Z",
"updateTime": "2023-11-28T10:44:12.771363903Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "125b9b9c1025997970c1b9ff053df5b835f179a1",
"ref": "refs/heads/main"
}
}
}
[10:44:13.316] Task URL: https://cr-buildbucket.appspot.com/build/8763189514140977025
[10:44:13.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:2:0) after 4m43s
[10:44:14.215] Received PubSub notification, asking Buildbucket for the build status
[10:44:14.238] Build status: SCHEDULED
[10:44:14.795] Received PubSub notification, asking Buildbucket for the build status
[10:44:14.835] Build status: STARTED
[10:48:56.349] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:2:0)
[10:48:56.372] Build status: STARTED
[10:48:56.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:5:0) after 3m55s
[10:52:51.388] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:5:0)
[10:52:51.565] Build status: STARTED
[10:52:51.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:6:0) after 3m40s
[10:56:31.760] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:6:0)
[10:56:31.783] Build status: STARTED
[10:56:31.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:7:0) after 8m7s
[11:04:39.006] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:7:0)
[11:04:39.039] Build status: STARTED
[11:04:39.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:8:0) after 5m11s
[11:09:50.096] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:8:0)
[11:09:50.117] Build status: STARTED
[11:09:50.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:9:0) after 6m29s
[11:16:19.096] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:9:0)
[11:16:19.125] Build status: STARTED
[11:16:19.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:10:0) after 4m38s
[11:20:57.470] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:10:0)
[11:20:57.502] Build status: STARTED
[11:20:57.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:11:0) after 2m36s
[11:23:33.523] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:11:0)
[11:23:33.552] Build status: STARTED
[11:23:33.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:12:0) after 1m0s
[11:24:33.572] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:12:0)
[11:24:33.601] Build status: STARTED
[11:24:33.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:13:0) after 7m8s
[11:31:41.793] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:13:0)
[11:31:41.811] Build status: STARTED
[11:31:41.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:14:0) after 9m29s
[11:41:10.837] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:14:0)
[11:41:10.857] Build status: STARTED
[11:41:10.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:15:0) after 4m54s
[11:46:05.082] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:15:0)
[11:46:05.098] Build status: STARTED
[11:46:05.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:16:0) after 9m58s
[11:56:03.361] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:16:0)
[11:56:03.383] Build status: STARTED
[11:56:03.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:17:0) after 3m26s
[11:59:29.397] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:17:0)
[11:59:29.418] Build status: STARTED
[11:59:29.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:18:0) after 5m41s
[12:05:10.600] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:18:0)
[12:05:10.625] Build status: STARTED
[12:05:10.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:19:0) after 8m13s
[12:13:23.690] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:19:0)
[12:13:23.714] Build status: STARTED
[12:13:23.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:20:0) after 3m56s
[12:17:20.050] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:20:0)
[12:17:20.075] Build status: STARTED
[12:17:20.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:21:0) after 4m10s
[12:21:30.285] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:21:0)
[12:21:30.333] Build status: STARTED
[12:21:30.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:22:0) after 6m31s
[12:28:01.349] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:22:0)
[12:28:01.368] Build status: STARTED
[12:28:01.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:23:0) after 3m23s
[12:31:24.416] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:23:0)
[12:31:24.450] Build status: STARTED
[12:31:24.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:24:0) after 7m43s
[12:39:07.462] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:24:0)
[12:39:07.487] Build status: STARTED
[12:39:07.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:25:0) after 7m42s
[12:46:49.751] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:25:0)
[12:46:49.769] Build status: STARTED
[12:46:49.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:26:0) after 4m24s
[12:51:14.085] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:26:0)
[12:51:14.114] Build status: STARTED
[12:51:14.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:27:0) after 4m39s
[12:55:53.407] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:27:0)
[12:55:53.433] Build status: STARTED
[12:55:53.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:28:0) after 4m3s
[12:59:56.454] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:28:0)
[12:59:56.488] Build status: STARTED
[12:59:56.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:29:0) after 2m59s
[13:02:55.713] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:29:0)
[13:02:55.745] Build status: STARTED
[13:02:55.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:30:0) after 8m23s
[13:11:18.863] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:30:0)
[13:11:18.887] Build status: STARTED
[13:11:18.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:31:0) after 4m11s
[13:15:29.904] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:31:0)
[13:15:29.922] Build status: STARTED
[13:15:29.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:32:0) after 7m22s
[13:22:52.044] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:32:0)
[13:22:52.091] Build status: STARTED
[13:22:52.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:33:0) after 6m30s
[13:29:22.114] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:33:0)
[13:29:22.135] Build status: STARTED
[13:29:22.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:34:0) after 9m33s
[13:38:55.239] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:34:0)
[13:38:55.261] Build status: STARTED
[13:38:55.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:35:0) after 5m38s
[13:44:33.376] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:35:0)
[13:44:33.399] Build status: STARTED
[13:44:33.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:36:0) after 6m41s
[13:51:14.421] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:36:0)
[13:51:14.543] Build status: STARTED
[13:51:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:37:0) after 9m13s
[14:00:27.572] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:37:0)
[14:00:27.651] Build status: STARTED
[14:00:27.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:38:0) after 9m8s
[14:09:35.669] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:38:0)
[14:09:35.706] Build status: STARTED
[14:09:35.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:39:0) after 7m58s
[14:17:33.991] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:39:0)
[14:17:34.021] Build status: STARTED
[14:17:34.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:40:0) after 6m0s
[14:23:34.482] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:40:0)
[14:23:34.518] Build status: STARTED
[14:23:34.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:41:0) after 9m38s
[14:33:12.585] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:41:0)
[14:33:12.606] Build status: STARTED
[14:33:12.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:42:0) after 3m56s
[14:37:08.632] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:42:0)
[14:37:08.654] Build status: STARTED
[14:37:08.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:43:0) after 4m50s
[14:41:58.677] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:43:0)
[14:41:58.716] Build status: STARTED
[14:41:58.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:44:0) after 6m23s
[14:48:21.756] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:44:0)
[14:48:21.826] Build status: STARTED
[14:48:21.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:45:0) after 7m13s
[14:55:35.761] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:45:0)
[14:55:35.784] Build status: STARTED
[14:55:35.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:46:0) after 9m4s
[15:04:39.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:46:0)
[15:04:39.837] Build status: STARTED
[15:04:39.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:47:0) after 5m39s
[15:10:18.906] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:47:0)
[15:10:18.952] Build status: STARTED
[15:10:18.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:48:0) after 4m29s
[15:14:48.242] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:48:0)
[15:14:48.268] Build status: STARTED
[15:14:48.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:49:0) after 1m18s
[15:16:06.298] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:49:0)
[15:16:06.320] Build status: STARTED
[15:16:06.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:50:0) after 4m21s
[15:20:27.630] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:50:0)
[15:20:27.661] Build status: STARTED
[15:20:27.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:51:0) after 7m59s
[15:28:26.678] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:51:0)
[15:28:26.705] Build status: STARTED
[15:28:26.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:52:0) after 1m20s
[15:29:46.733] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:52:0)
[15:29:46.765] Build status: STARTED
[15:29:46.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:53:0) after 1m10s
[15:30:57.061] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:53:0)
[15:30:57.127] Build status: STARTED
[15:30:57.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:54:0) after 8m56s
[15:39:53.149] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:54:0)
[15:39:53.177] Build status: STARTED
[15:39:53.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:55:0) after 8m3s
[15:47:56.201] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:55:0)
[15:47:56.238] Build status: STARTED
[15:47:56.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:56:0) after 7m58s
[15:55:54.265] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:56:0)
[15:55:54.299] Build status: STARTED
[15:55:54.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:57:0) after 7m29s
[16:03:23.410] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:57:0)
[16:03:23.434] Build status: STARTED
[16:03:23.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:58:0) after 7m23s
[16:10:46.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:58:0)
[16:10:46.878] Build status: STARTED
[16:10:46.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:59:0) after 8m13s
[16:18:59.902] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:59:0)
[16:18:59.983] Build status: STARTED
[16:18:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:60:0) after 2m21s
[16:21:21.113] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:60:0)
[16:21:21.136] Build status: STARTED
[16:21:21.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:61:0) after 9m27s
[16:30:48.199] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:61:0)
[16:30:48.817] Build status: STARTED
[16:30:48.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:62:0) after 5m37s
[16:36:25.856] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:62:0)
[16:36:25.913] Build status: STARTED
[16:36:25.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:63:0) after 2m28s
[16:38:54.220] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:63:0)
[16:38:54.245] Build status: STARTED
[16:38:54.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:64:0) after 9m17s
[16:48:12.272] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:64:0)
[16:48:12.330] Build status: STARTED
[16:48:12.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:65:0) after 7m12s
[16:55:24.690] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:65:0)
[16:55:24.728] Build status: STARTED
[16:55:24.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:66:0) after 3m29s
[16:58:53.762] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:66:0)
[16:58:53.780] Build status: STARTED
[16:58:53.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:67:0) after 6m36s
[17:05:29.919] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:67:0)
[17:05:29.970] Build status: STARTED
[17:05:29.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:68:0) after 2m22s
[17:07:51.988] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:68:0)
[17:07:52.008] Build status: STARTED
[17:07:52.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:69:0) after 9m24s
[17:17:16.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:69:0)
[17:17:16.107] Build status: STARTED
[17:17:16.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:70:0) after 6m41s
[17:23:57.175] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:70:0)
[17:23:57.215] Build status: STARTED
[17:23:57.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:71:0) after 7m4s
[17:31:01.262] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:71:0)
[17:31:01.294] Build status: STARTED
[17:31:01.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:72:0) after 2m9s
[17:33:10.510] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:72:0)
[17:33:10.533] Build status: STARTED
[17:33:10.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:73:0) after 2m22s
[17:35:32.561] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:73:0)
[17:35:32.578] Build status: STARTED
[17:35:32.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:74:0) after 1m53s
[17:37:25.789] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:74:0)
[17:37:25.821] Build status: STARTED
[17:37:25.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:75:0) after 1m41s
[17:39:07.000] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:75:0)
[17:39:07.030] Build status: STARTED
[17:39:07.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:76:0) after 3m14s
[17:42:21.173] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:76:0)
[17:42:21.217] Build status: STARTED
[17:42:21.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:77:0) after 1m19s
[17:43:40.822] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:77:0)
[17:43:40.841] Build status: STARTED
[17:43:40.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:78:0) after 7m25s
[17:51:05.904] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:78:0)
[17:51:05.924] Build status: STARTED
[17:51:05.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:79:0) after 9m19s
[18:00:25.021] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:79:0)
[18:00:25.041] Build status: STARTED
[18:00:25.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:80:0) after 4m21s
[18:04:46.030] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:80:0)
[18:04:46.065] Build status: STARTED
[18:04:46.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:81:0) after 5m30s
[18:10:16.111] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:81:0)
[18:10:16.159] Build status: STARTED
[18:10:16.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:82:0) after 2m19s
[18:12:35.132] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:82:0)
[18:12:35.155] Build status: STARTED
[18:12:35.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:83:0) after 9m20s
[18:21:55.139] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:83:0)
[18:21:55.160] Build status: STARTED
[18:21:55.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:84:0) after 2m9s
[18:24:04.241] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:84:0)
[18:24:04.298] Build status: STARTED
[18:24:04.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:85:0) after 5m48s
[18:29:52.323] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:85:0)
[18:29:52.343] Build status: STARTED
[18:29:52.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:86:0) after 7m29s
[18:37:21.370] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:86:0)
[18:37:21.394] Build status: STARTED
[18:37:21.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:87:0) after 6m34s
[18:43:55.432] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:87:0)
[18:43:55.455] Build status: STARTED
[18:43:55.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:88:0) after 4m21s
[18:48:16.475] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:88:0)
[18:48:16.491] Build status: STARTED
[18:48:16.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:89:0) after 2m30s
[18:50:46.508] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:89:0)
[18:50:46.538] Build status: STARTED
[18:50:46.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:90:0) after 2m11s
[18:52:57.562] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:90:0)
[18:52:57.583] Build status: STARTED
[18:52:57.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:91:0) after 2m38s
[18:55:35.607] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:91:0)
[18:55:35.650] Build status: STARTED
[18:55:35.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:92:0) after 5m2s
[19:00:37.630] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:92:0)
[19:00:37.665] Build status: STARTED
[19:00:37.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:93:0) after 7m34s
[19:08:11.869] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:93:0)
[19:08:11.890] Build status: STARTED
[19:08:11.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:94:0) after 7m57s
[19:16:08.979] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:94:0)
[19:16:09.001] Build status: STARTED
[19:16:09.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:95:0) after 7m8s
[19:23:17.024] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:95:0)
[19:23:17.043] Build status: STARTED
[19:23:17.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:96:0) after 7m27s
[19:30:44.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:96:0)
[19:30:44.129] Build status: STARTED
[19:30:44.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:97:0) after 3m38s
[19:34:22.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:97:0)
[19:34:22.631] Build status: STARTED
[19:34:22.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:98:0) after 6m35s
[19:40:57.664] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:98:0)
[19:40:57.910] Build status: STARTED
[19:40:57.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:99:0) after 4m59s
[19:45:57.103] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:99:0)
[19:45:57.136] Build status: STARTED
[19:45:57.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:100:0) after 7m31s
[19:53:28.223] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:100:0)
[19:53:28.248] Build status: STARTED
[19:53:28.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:101:0) after 1m50s
[19:55:18.277] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:101:0)
[19:55:18.363] Build status: STARTED
[19:55:18.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:102:0) after 2m4s
[19:57:22.438] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:102:0)
[19:57:22.469] Build status: STARTED
[19:57:22.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:103:0) after 7m58s
[20:05:20.498] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:103:0)
[20:05:20.525] Build status: STARTED
[20:05:20.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:104:0) after 4m45s
[20:10:05.603] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:104:0)
[20:10:05.633] Build status: STARTED
[20:10:05.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:105:0) after 5m34s
[20:15:39.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:105:0)
[20:15:39.809] Build status: STARTED
[20:15:39.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:106:0) after 4m13s
[20:19:52.864] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:106:0)
[20:19:52.887] Build status: STARTED
[20:19:52.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:107:0) after 3m1s
[20:22:53.870] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:107:0)
[20:22:53.895] Build status: STARTED
[20:22:53.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:108:0) after 6m51s
[20:29:44.915] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:108:0)
[20:29:44.933] Build status: STARTED
[20:29:44.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:109:0) after 8m59s
[20:38:43.997] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:109:0)
[20:38:44.082] Build status: STARTED
[20:38:44.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:110:0) after 9m49s
[20:48:33.133] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:110:0)
[20:48:33.152] Build status: STARTED
[20:48:33.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:111:0) after 2m10s
[20:50:43.191] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:111:0)
[20:50:43.222] Build status: STARTED
[20:50:43.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:112:0) after 2m15s
[20:52:58.252] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:112:0)
[20:52:58.328] Build status: STARTED
[20:52:58.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:113:0) after 1m8s
[20:54:06.353] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:113:0)
[20:54:06.372] Build status: STARTED
[20:54:06.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:114:0) after 4m18s
[20:58:24.394] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:114:0)
[20:58:24.414] Build status: STARTED
[20:58:24.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:115:0) after 9m37s
[21:08:01.451] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:115:0)
[21:08:01.474] Build status: STARTED
[21:08:01.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:116:0) after 2m25s
[21:10:26.519] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:116:0)
[21:10:26.558] Build status: STARTED
[21:10:26.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:117:0) after 9m32s
[21:19:58.639] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:117:0)
[21:19:58.730] Build status: STARTED
[21:19:58.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:118:0) after 6m31s
[21:26:29.800] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:118:0)
[21:26:29.822] Build status: STARTED
[21:26:29.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:119:0) after 8m4s
[21:34:33.841] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:119:0)
[21:34:33.860] Build status: STARTED
[21:34:33.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:120:0) after 1m47s
[21:36:20.941] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:120:0)
[21:36:20.971] Build status: STARTED
[21:36:20.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:121:0) after 7m1s
[21:43:22.050] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:121:0)
[21:43:22.079] Build status: STARTED
[21:43:22.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:122:0) after 8m4s
[21:51:26.059] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:122:0)
[21:51:26.097] Build status: STARTED
[21:51:26.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:123:0) after 8m29s
[21:59:55.104] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:123:0)
[21:59:55.125] Build status: STARTED
[21:59:55.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:124:0) after 5m47s
[22:05:42.125] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:124:0)
[22:05:42.193] Build status: STARTED
[22:05:42.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:125:0) after 2m39s
[22:08:21.281] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:125:0)
[22:08:21.300] Build status: STARTED
[22:08:21.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:126:0) after 9m7s
[22:17:28.326] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:126:0)
[22:17:28.350] Build status: STARTED
[22:17:28.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:127:0) after 8m5s
[22:25:33.383] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:127:0)
[22:25:33.405] Build status: STARTED
[22:25:33.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:128:0) after 5m8s
[22:30:41.427] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:128:0)
[22:30:41.450] Build status: STARTED
[22:30:41.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:129:0) after 3m19s
[22:34:00.549] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:129:0)
[22:34:00.582] Build status: STARTED
[22:34:00.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:130:0) after 5m46s
[22:39:46.598] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:130:0)
[22:39:46.623] Build status: STARTED
[22:39:46.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:131:0) after 7m9s
[22:46:55.717] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:131:0)
[22:46:55.738] Build status: STARTED
[22:46:55.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:132:0) after 3m9s
[22:50:04.798] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:132:0)
[22:50:04.829] Build status: STARTED
[22:50:04.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:133:0) after 5m38s
[22:55:43.033] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:133:0)
[22:55:43.056] Build status: STARTED
[22:55:43.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:134:0) after 2m58s
[22:58:41.160] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:134:0)
[22:58:41.186] Build status: STARTED
[22:58:41.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:135:0) after 5m48s
[23:04:29.216] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:135:0)
[23:04:29.237] Build status: STARTED
[23:04:29.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:136:0) after 6m53s
[23:11:22.263] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:136:0)
[23:11:22.282] Build status: STARTED
[23:11:22.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:137:0) after 8m40s
[23:20:02.524] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:137:0)
[23:20:02.557] Build status: STARTED
[23:20:02.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:138:0) after 9m0s
[23:29:02.588] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:138:0)
[23:29:02.607] Build status: STARTED
[23:29:02.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:139:0) after 4m58s
[23:34:00.961] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:139:0)
[23:34:00.994] Build status: STARTED
[23:34:00.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:140:0) after 4m32s
[23:38:33.019] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:140:0)
[23:38:33.037] Build status: STARTED
[23:38:33.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:141:0) after 8m32s
[23:47:05.064] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:141:0)
[23:47:05.085] Build status: STARTED
[23:47:05.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:142:0) after 6m24s
[23:53:29.703] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:142:0)
[23:53:29.729] Build status: STARTED
[23:53:29.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:143:0) after 1m31s
[23:55:00.816] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:143:0)
[23:55:00.835] Build status: STARTED
[23:55:00.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:144:0) after 4m13s
[23:59:13.988] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:144:0)
[23:59:14.031] Build status: STARTED
[23:59:14.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:145:0) after 7m45s
[00:06:59.133] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:145:0)
[00:06:59.166] Build status: STARTED
[00:06:59.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:146:0) after 7m22s
[00:14:21.191] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:146:0)
[00:14:21.208] Build status: STARTED
[00:14:21.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:147:0) after 8m54s
[00:23:15.262] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:147:0)
[00:23:15.422] Build status: STARTED
[00:23:15.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:148:0) after 5m57s
[00:29:13.256] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:148:0)
[00:29:13.277] Build status: STARTED
[00:29:13.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:149:0) after 1m16s
[00:30:29.294] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:149:0)
[00:30:29.315] Build status: STARTED
[00:30:29.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:150:0) after 7m27s
[00:37:57.012] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:150:0)
[00:37:57.032] Build status: STARTED
[00:37:57.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:151:0) after 1m8s
[00:39:05.155] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:151:0)
[00:39:05.177] Build status: STARTED
[00:39:05.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:152:0) after 7m8s
[00:46:13.203] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:152:0)
[00:46:13.229] Build status: STARTED
[00:46:13.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:153:0) after 4m51s
[00:51:04.307] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:153:0)
[00:51:04.328] Build status: STARTED
[00:51:04.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:154:0) after 1m58s
[00:53:03.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:154:0)
[00:53:03.075] Build status: STARTED
[00:53:03.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:155:0) after 1m25s
[00:54:28.105] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:155:0)
[00:54:28.126] Build status: STARTED
[00:54:28.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:156:0) after 8m11s
[01:02:39.205] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:156:0)
[01:02:39.232] Build status: STARTED
[01:02:39.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:157:0) after 2m4s
[01:04:43.253] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:157:0)
[01:04:43.276] Build status: STARTED
[01:04:43.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:158:0) after 8m36s
[01:13:19.293] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:158:0)
[01:13:19.322] Build status: STARTED
[01:13:19.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:159:0) after 9m47s
[01:23:06.866] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:159:0)
[01:23:06.893] Build status: STARTED
[01:23:06.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:160:0) after 9m25s
[01:32:32.154] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:160:0)
[01:32:32.171] Build status: STARTED
[01:32:32.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:161:0) after 7m5s
[01:39:37.638] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:161:0)
[01:39:37.656] Build status: STARTED
[01:39:37.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:162:0) after 9m52s
[01:49:29.684] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:162:0)
[01:49:29.705] Build status: STARTED
[01:49:29.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:163:0) after 9m6s
[01:58:35.860] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:163:0)
[01:58:35.881] Build status: STARTED
[01:58:35.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:164:0) after 4m46s
[02:03:22.277] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:164:0)
[02:03:22.296] Build status: STARTED
[02:03:22.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:165:0) after 9m10s
[02:12:32.420] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:165:0)
[02:12:32.439] Build status: STARTED
[02:12:32.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:166:0) after 2m26s
[02:14:58.585] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:166:0)
[02:14:58.602] Build status: STARTED
[02:14:58.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:167:0) after 3m25s
[02:18:23.622] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:167:0)
[02:18:23.642] Build status: STARTED
[02:18:23.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:168:0) after 9m31s
[02:27:54.665] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:168:0)
[02:27:54.688] Build status: STARTED
[02:27:54.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:169:0) after 2m40s
[02:30:35.008] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:169:0)
[02:30:35.056] Build status: STARTED
[02:30:35.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:170:0) after 6m41s
[02:37:16.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:170:0)
[02:37:16.106] Build status: STARTED
[02:37:16.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:171:0) after 5m33s
[02:42:49.231] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:171:0)
[02:42:49.252] Build status: STARTED
[02:42:49.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:172:0) after 8m54s
[02:51:43.517] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:172:0)
[02:51:43.545] Build status: STARTED
[02:51:43.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:173:0) after 2m51s
[02:54:34.727] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:173:0)
[02:54:34.748] Build status: STARTED
[02:54:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:174:0) after 1m4s
[02:55:38.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:174:0)
[02:55:38.796] Build status: STARTED
[02:55:38.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:175:0) after 2m35s
[02:58:13.817] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:175:0)
[02:58:13.839] Build status: STARTED
[02:58:13.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:176:0) after 7m13s
[03:05:27.015] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:176:0)
[03:05:27.059] Build status: STARTED
[03:05:27.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:177:0) after 4m30s
[03:09:57.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:177:0)
[03:09:57.121] Build status: STARTED
[03:09:57.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:178:0) after 3m0s
[03:12:57.241] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:178:0)
[03:12:57.260] Build status: STARTED
[03:12:57.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:179:0) after 2m32s
[03:15:29.547] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:179:0)
[03:15:29.576] Build status: STARTED
[03:15:29.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:180:0) after 2m24s
[03:17:54.666] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:180:0)
[03:17:54.859] Build status: STARTED
[03:17:54.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:181:0) after 9m57s
[03:27:51.930] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:181:0)
[03:27:51.953] Build status: STARTED
[03:27:51.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:182:0) after 2m10s
[03:30:02.371] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:182:0)
[03:30:02.401] Build status: STARTED
[03:30:02.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:183:0) after 6m30s
[03:36:32.553] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:183:0)
[03:36:32.576] Build status: STARTED
[03:36:32.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:184:0) after 8m23s
[03:44:55.891] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:184:0)
[03:44:55.910] Build status: STARTED
[03:44:55.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:185:0) after 2m56s
[03:47:52.891] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:185:0)
[03:47:52.920] Build status: STARTED
[03:47:52.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:186:0) after 1m52s
[03:49:44.955] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:186:0)
[03:49:45.001] Build status: STARTED
[03:49:45.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:187:0) after 6m6s
[03:55:51.203] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:187:0)
[03:55:51.222] Build status: STARTED
[03:55:51.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:188:0) after 5m14s
[04:01:05.285] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:188:0)
[04:01:05.305] Build status: STARTED
[04:01:05.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:189:0) after 8m23s
[04:09:28.925] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:189:0)
[04:09:28.942] Build status: STARTED
[04:09:28.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:190:0) after 9m5s
[04:18:34.077] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:190:0)
[04:18:34.109] Build status: STARTED
[04:18:34.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:191:0) after 7m16s
[04:25:50.136] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:191:0)
[04:25:50.159] Build status: STARTED
[04:25:50.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:192:0) after 7m40s
[04:33:30.229] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:192:0)
[04:33:30.298] Build status: STARTED
[04:33:30.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:193:0) after 8m2s
[04:41:32.360] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:193:0)
[04:41:32.386] Build status: STARTED
[04:41:32.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:194:0) after 9m24s
[04:50:56.558] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:194:0)
[04:50:56.578] Build status: STARTED
[04:50:56.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:195:0) after 5m6s
[04:56:02.612] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:195:0)
[04:56:02.630] Build status: STARTED
[04:56:02.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:196:0) after 5m7s
[05:01:09.663] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:196:0)
[05:01:09.696] Build status: STARTED
[05:01:09.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:197:0) after 7m34s
[05:08:43.867] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:197:0)
[05:08:43.887] Build status: STARTED
[05:08:43.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:198:0) after 6m3s
[05:14:47.051] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:198:0)
[05:14:47.075] Build status: STARTED
[05:14:47.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:199:0) after 2m48s
[05:17:35.408] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:199:0)
[05:17:35.437] Build status: STARTED
[05:17:35.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:200:0) after 2m42s
[05:20:17.888] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:200:0)
[05:20:17.913] Build status: STARTED
[05:20:17.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:201:0) after 4m9s
[05:24:27.407] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:201:0)
[05:24:27.430] Build status: STARTED
[05:24:27.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:202:0) after 1m20s
[05:25:47.578] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:202:0)
[05:25:47.620] Build status: STARTED
[05:25:47.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:203:0) after 5m3s
[05:30:50.841] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:203:0)
[05:30:50.916] Build status: STARTED
[05:30:50.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:204:0) after 4m24s
[05:35:15.362] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:204:0)
[05:35:15.387] Build status: STARTED
[05:35:15.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:205:0) after 6m8s
[05:41:23.615] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:205:0)
[05:41:23.640] Build status: STARTED
[05:41:23.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:206:0) after 5m20s
[05:46:43.689] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:206:0)
[05:46:43.714] Build status: STARTED
[05:46:43.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:207:0) after 8m43s
[05:55:26.769] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:207:0)
[05:55:26.803] Build status: STARTED
[05:55:26.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:208:0) after 3m15s
[05:58:41.946] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:208:0)
[05:58:41.964] Build status: STARTED
[05:58:41.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:209:0) after 1m39s
[06:00:21.323] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:209:0)
[06:00:21.363] Build status: STARTED
[06:00:21.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:210:0) after 6m37s
[06:06:58.556] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:210:0)
[06:06:58.577] Build status: STARTED
[06:06:58.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:211:0) after 3m35s
[06:10:33.659] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:211:0)
[06:10:33.681] Build status: STARTED
[06:10:33.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:212:0) after 9m49s
[06:20:23.134] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:212:0)
[06:20:23.168] Build status: STARTED
[06:20:23.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:213:0) after 7m36s
[06:27:59.290] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:213:0)
[06:27:59.308] Build status: STARTED
[06:27:59.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:214:0) after 6m5s
[06:34:04.433] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:214:0)
[06:34:04.468] Build status: STARTED
[06:34:04.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:215:0) after 9m43s
[06:43:47.488] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:215:0)
[06:43:47.509] Build status: STARTED
[06:43:47.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:216:0) after 1m27s
[06:45:14.668] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:216:0)
[06:45:14.693] Build status: STARTED
[06:45:14.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8928619576690539392:217:0) after 6m51s
[06:47:21.644] Received PubSub notification, asking Buildbucket for the build status
[06:47:21.660] Build:
{
"id": "8763189514140977025",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 31391,
"createdBy": "project:chromium",
"createTime": "2023-11-28T10:44:12.771363903Z",
"startTime": "2023-11-28T10:44:14.139163Z",
"endTime": "2023-11-29T06:47:20.794042Z",
"updateTime": "2023-11-29T06:47:20.794042Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "125b9b9c1025997970c1b9ff053df5b835f179a1",
"ref": "refs/heads/main"
}
}
}
[06:47:21.660] Invocation finished in 20h3m10.703578176s with status FAILED