[09:07:32.086] New invocation is queued and will start shortly
[09:07:33.175] Starting the invocation (attempt 1)
[09:07:33.242] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/276d11cb3786768e7704b40f6da9c6bd7f65fe3b"
[09:07:33.242] Popped gitiles commit info from properties and tags
[09:07:33.242] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:07:33.242] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:07:33.242] Buildbucket request:
{
"requestId": "8991590548907247968",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "276d11cb3786768e7704b40f6da9c6bd7f65fe3b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8991590548907247968"
},
{
"key": "scheduler_job_id",
"value": "chromium/mac-code-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:07:33.765] Scheduled build:
{
"id": "8826160486986998881",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 7027,
"createdBy": "project:chromium",
"createTime": "2022-01-02T09:07:33.288513744Z",
"updateTime": "2022-01-02T09:07:33.288513744Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "276d11cb3786768e7704b40f6da9c6bd7f65fe3b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[09:07:33.765] Task URL: https://cr-buildbucket.appspot.com/build/8826160486986998881
[09:07:33.765] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:2:0) after 1m21s
[09:08:54.782] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:2:0)
[09:08:54.802] Build status: SCHEDULED
[09:08:54.802] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:3:0) after 7m14s
[09:16:08.819] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:3:0)
[09:16:08.872] Build status: SCHEDULED
[09:16:08.872] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:4:0) after 7m6s
[09:18:49.169] Received PubSub notification, asking Buildbucket for the build status
[09:18:49.202] Build status: STARTED
[09:23:14.967] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:4:0)
[09:23:14.984] Build status: STARTED
[09:23:14.984] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:6:0) after 1m25s
[09:24:40.028] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:6:0)
[09:24:40.045] Build status: STARTED
[09:24:40.045] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:7:0) after 4m11s
[09:28:51.402] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:7:0)
[09:28:51.421] Build status: STARTED
[09:28:51.421] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:8:0) after 5m42s
[09:34:33.575] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:8:0)
[09:34:33.592] Build status: STARTED
[09:34:33.592] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:9:0) after 6m48s
[09:41:21.608] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:9:0)
[09:41:21.650] Build status: STARTED
[09:41:21.651] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:10:0) after 8m35s
[09:49:56.670] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:10:0)
[09:49:56.696] Build status: STARTED
[09:49:56.696] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:11:0) after 7m41s
[09:57:37.713] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:11:0)
[09:57:37.739] Build status: STARTED
[09:57:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:12:0) after 3m34s
[10:01:11.954] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:12:0)
[10:01:11.986] Build status: STARTED
[10:01:11.986] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:13:0) after 8m7s
[10:09:19.002] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:13:0)
[10:09:19.022] Build status: STARTED
[10:09:19.022] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:14:0) after 6m46s
[10:16:05.083] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:14:0)
[10:16:05.117] Build status: STARTED
[10:16:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:15:0) after 6m34s
[10:22:39.136] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:15:0)
[10:22:39.154] Build status: STARTED
[10:22:39.154] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:16:0) after 8m40s
[10:31:19.173] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:16:0)
[10:31:19.199] Build status: STARTED
[10:31:19.199] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:17:0) after 9m47s
[10:41:06.333] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:17:0)
[10:41:06.363] Build status: STARTED
[10:41:06.363] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:18:0) after 3m3s
[10:44:09.384] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:18:0)
[10:44:09.409] Build status: STARTED
[10:44:09.409] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:19:0) after 6m32s
[10:50:41.425] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:19:0)
[10:50:41.471] Build status: STARTED
[10:50:41.471] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:20:0) after 9m40s
[11:00:21.981] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:20:0)
[11:00:22.013] Build status: STARTED
[11:00:22.013] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:21:0) after 1m54s
[11:02:16.380] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:21:0)
[11:02:16.408] Build status: STARTED
[11:02:16.408] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:22:0) after 6m3s
[11:08:19.702] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:22:0)
[11:08:19.779] Build status: STARTED
[11:08:19.779] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:23:0) after 1m13s
[11:09:32.876] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:23:0)
[11:09:32.902] Build status: STARTED
[11:09:32.902] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:24:0) after 3m20s
[11:12:52.920] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:24:0)
[11:12:52.952] Build status: STARTED
[11:12:52.952] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:25:0) after 3m7s
[11:16:00.106] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:25:0)
[11:16:00.184] Build status: STARTED
[11:16:00.184] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:26:0) after 4m39s
[11:20:39.422] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:26:0)
[11:20:39.451] Build status: STARTED
[11:20:39.451] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:27:0) after 1m48s
[11:22:27.665] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:27:0)
[11:22:27.691] Build status: STARTED
[11:22:27.691] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:28:0) after 6m18s
[11:28:45.709] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:28:0)
[11:28:45.736] Build status: STARTED
[11:28:45.736] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:29:0) after 9m38s
[11:38:23.858] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:29:0)
[11:38:23.893] Build status: STARTED
[11:38:23.893] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:30:0) after 8m49s
[11:47:12.912] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:30:0)
[11:47:12.951] Build status: STARTED
[11:47:12.951] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:31:0) after 7m16s
[11:54:29.266] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:31:0)
[11:54:29.290] Build status: STARTED
[11:54:29.290] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:32:0) after 7m32s
[12:02:01.406] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:32:0)
[12:02:01.447] Build status: STARTED
[12:02:01.447] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:33:0) after 9m53s
[12:11:54.483] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:33:0)
[12:11:54.540] Build status: STARTED
[12:11:54.541] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:34:0) after 9m2s
[12:20:56.559] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:34:0)
[12:20:56.577] Build status: STARTED
[12:20:56.577] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:35:0) after 6m33s
[12:27:29.598] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:35:0)
[12:27:29.614] Build status: STARTED
[12:27:29.614] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:36:0) after 4m34s
[12:32:03.784] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:36:0)
[12:32:03.812] Build status: STARTED
[12:32:03.812] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:37:0) after 4m35s
[12:36:38.986] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:37:0)
[12:36:39.028] Build status: STARTED
[12:36:39.028] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:38:0) after 9m40s
[12:46:19.047] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:38:0)
[12:46:19.073] Build status: STARTED
[12:46:19.073] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:39:0) after 5m43s
[12:52:02.312] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:39:0)
[12:52:02.340] Build status: STARTED
[12:52:02.340] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:40:0) after 3m25s
[12:55:27.360] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:40:0)
[12:55:27.382] Build status: STARTED
[12:55:27.382] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:41:0) after 3m47s
[12:59:14.810] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:41:0)
[12:59:14.828] Build status: STARTED
[12:59:14.828] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:42:0) after 9m12s
[13:08:26.846] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:42:0)
[13:08:26.883] Build status: STARTED
[13:08:26.883] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:43:0) after 1m36s
[13:10:03.011] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:43:0)
[13:10:03.028] Build status: STARTED
[13:10:03.028] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:44:0) after 9m26s
[13:19:29.054] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:44:0)
[13:19:29.072] Build status: STARTED
[13:19:29.072] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:45:0) after 5m32s
[13:25:01.091] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:45:0)
[13:25:01.846] Build status: STARTED
[13:25:01.846] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:46:0) after 7m17s
[13:32:18.884] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:46:0)
[13:32:18.918] Build status: STARTED
[13:32:18.918] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:47:0) after 5m23s
[13:37:41.936] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:47:0)
[13:37:41.957] Build status: STARTED
[13:37:41.957] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:48:0) after 3m28s
[13:41:09.947] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:48:0)
[13:41:09.977] Build status: STARTED
[13:41:09.977] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:49:0) after 5m0s
[13:46:10.092] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:49:0)
[13:46:10.145] Build status: STARTED
[13:46:10.145] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:50:0) after 9m13s
[13:55:23.209] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:50:0)
[13:55:23.248] Build status: STARTED
[13:55:23.248] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:51:0) after 3m5s
[13:58:28.271] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:51:0)
[13:58:28.286] Build status: STARTED
[13:58:28.286] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:52:0) after 5m37s
[14:04:05.339] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:52:0)
[14:04:05.385] Build status: STARTED
[14:04:05.385] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:53:0) after 6m35s
[14:10:40.405] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:53:0)
[14:10:40.423] Build status: STARTED
[14:10:40.423] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:54:0) after 7m20s
[14:18:00.477] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:54:0)
[14:18:00.497] Build status: STARTED
[14:18:00.497] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:55:0) after 3m46s
[14:21:46.518] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:55:0)
[14:21:46.536] Build status: STARTED
[14:21:46.536] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:56:0) after 1m12s
[14:22:58.621] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:56:0)
[14:22:58.648] Build status: STARTED
[14:22:58.648] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:57:0) after 6m12s
[14:29:10.667] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:57:0)
[14:29:10.686] Build status: STARTED
[14:29:10.686] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:58:0) after 6m42s
[14:35:52.824] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:58:0)
[14:35:52.986] Build status: STARTED
[14:35:52.986] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:59:0) after 7m23s
[14:43:16.018] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:59:0)
[14:43:16.050] Build status: STARTED
[14:43:16.050] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:60:0) after 9m41s
[14:52:57.501] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:60:0)
[14:52:57.531] Build status: STARTED
[14:52:57.531] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:61:0) after 8m23s
[15:01:21.188] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:61:0)
[15:01:21.215] Build status: STARTED
[15:01:21.215] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:62:0) after 2m24s
[15:03:45.248] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:62:0)
[15:03:45.276] Build status: STARTED
[15:03:45.276] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:63:0) after 7m17s
[15:11:02.327] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:63:0)
[15:11:02.379] Build status: STARTED
[15:11:02.379] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:64:0) after 7m31s
[15:18:33.507] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:64:0)
[15:18:33.527] Build status: STARTED
[15:18:33.527] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:65:0) after 9m3s
[15:27:37.436] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:65:0)
[15:27:37.483] Build status: STARTED
[15:27:37.483] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:66:0) after 4m41s
[15:32:18.503] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:66:0)
[15:32:18.535] Build status: STARTED
[15:32:18.535] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:67:0) after 2m4s
[15:34:22.845] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:67:0)
[15:34:22.863] Build status: STARTED
[15:34:22.864] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:68:0) after 3m18s
[15:37:41.084] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:68:0)
[15:37:41.110] Build status: STARTED
[15:37:41.110] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:69:0) after 3m34s
[15:41:15.603] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:69:0)
[15:41:15.636] Build status: STARTED
[15:41:15.636] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:70:0) after 5m14s
[15:46:29.654] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:70:0)
[15:46:29.682] Build status: STARTED
[15:46:29.682] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:71:0) after 8m55s
[15:55:25.514] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:71:0)
[15:55:25.530] Build status: STARTED
[15:55:25.530] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:72:0) after 3m54s
[15:59:19.568] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:72:0)
[15:59:19.621] Build status: STARTED
[15:59:19.621] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:73:0) after 6m57s
[16:06:17.063] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:73:0)
[16:06:17.081] Build status: STARTED
[16:06:17.081] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:74:0) after 1m31s
[16:07:48.079] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:74:0)
[16:07:48.098] Build status: STARTED
[16:07:48.098] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:75:0) after 1m41s
[16:09:29.383] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:75:0)
[16:09:29.401] Build status: STARTED
[16:09:29.401] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:76:0) after 2m21s
[16:11:50.418] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:76:0)
[16:11:50.441] Build status: STARTED
[16:11:50.441] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:77:0) after 3m12s
[16:15:02.459] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:77:0)
[16:15:02.483] Build status: STARTED
[16:15:02.483] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:78:0) after 2m42s
[16:17:44.501] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:78:0)
[16:17:44.527] Build status: STARTED
[16:17:44.527] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:79:0) after 3m4s
[16:20:48.760] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:79:0)
[16:20:48.792] Build status: STARTED
[16:20:48.792] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:80:0) after 6m36s
[16:27:24.809] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:80:0)
[16:27:24.837] Build status: STARTED
[16:27:24.837] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:81:0) after 6m41s
[16:34:05.857] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:81:0)
[16:34:05.883] Build status: STARTED
[16:34:05.883] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:82:0) after 2m30s
[16:36:35.901] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:82:0)
[16:36:36.070] Build status: STARTED
[16:36:36.070] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:83:0) after 5m43s
[16:42:19.183] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:83:0)
[16:42:19.203] Build status: STARTED
[16:42:19.203] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:84:0) after 1m12s
[16:43:31.389] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:84:0)
[16:43:31.415] Build status: STARTED
[16:43:31.415] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:85:0) after 5m57s
[16:49:28.442] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:85:0)
[16:49:28.507] Build status: STARTED
[16:49:28.507] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:86:0) after 4m9s
[16:53:37.528] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:86:0)
[16:53:37.552] Build status: STARTED
[16:53:37.552] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:87:0) after 2m15s
[16:55:52.750] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:87:0)
[16:55:52.772] Build status: STARTED
[16:55:52.772] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:88:0) after 4m7s
[17:00:00.233] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:88:0)
[17:00:00.278] Build status: STARTED
[17:00:00.278] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:89:0) after 5m33s
[17:05:33.294] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:89:0)
[17:05:33.317] Build status: STARTED
[17:05:33.317] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:90:0) after 4m39s
[17:10:12.392] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:90:0)
[17:10:12.482] Build status: STARTED
[17:10:12.482] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:91:0) after 3m0s
[17:13:12.772] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:91:0)
[17:13:12.800] Build status: STARTED
[17:13:12.800] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:92:0) after 8m37s
[17:21:49.912] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:92:0)
[17:21:49.939] Build status: STARTED
[17:21:49.939] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:93:0) after 9m10s
[17:30:59.978] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:93:0)
[17:30:59.997] Build status: STARTED
[17:30:59.997] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:94:0) after 5m35s
[17:36:35.019] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:94:0)
[17:36:35.052] Build status: STARTED
[17:36:35.052] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:95:0) after 1m32s
[17:38:07.029] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:95:0)
[17:38:07.046] Build status: STARTED
[17:38:07.046] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:96:0) after 7m27s
[17:45:34.118] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:96:0)
[17:45:34.134] Build status: STARTED
[17:45:34.134] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:97:0) after 9m3s
[17:54:37.171] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:97:0)
[17:54:37.201] Build status: STARTED
[17:54:37.201] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:98:0) after 9m52s
[18:04:29.312] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:98:0)
[18:04:29.388] Build status: STARTED
[18:04:29.388] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:99:0) after 3m46s
[18:08:15.405] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:99:0)
[18:08:15.432] Build status: STARTED
[18:08:15.433] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:100:0) after 2m40s
[18:10:55.879] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:100:0)
[18:10:55.903] Build status: STARTED
[18:10:55.903] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:101:0) after 6m41s
[18:17:36.922] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:101:0)
[18:17:36.940] Build status: STARTED
[18:17:36.940] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:102:0) after 2m7s
[18:19:44.160] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:102:0)
[18:19:44.184] Build status: STARTED
[18:19:44.184] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:103:0) after 9m21s
[18:29:05.582] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:103:0)
[18:29:05.610] Build status: STARTED
[18:29:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:104:0) after 5m38s
[18:34:43.812] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:104:0)
[18:34:43.858] Build status: STARTED
[18:34:43.858] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:105:0) after 3m27s
[18:38:10.854] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:105:0)
[18:38:10.940] Build status: STARTED
[18:38:10.940] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:106:0) after 2m19s
[18:40:29.996] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:106:0)
[18:40:30.024] Build status: STARTED
[18:40:30.024] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:107:0) after 5m59s
[18:46:29.049] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:107:0)
[18:46:29.077] Build status: STARTED
[18:46:29.077] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:108:0) after 2m9s
[18:48:38.222] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:108:0)
[18:48:38.250] Build status: STARTED
[18:48:38.251] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:109:0) after 6m38s
[18:55:16.537] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:109:0)
[18:55:16.556] Build status: STARTED
[18:55:16.556] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:110:0) after 2m52s
[18:58:09.143] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:110:0)
[18:58:09.160] Build status: STARTED
[18:58:09.160] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8991590548907247968:111:0) after 3m48s
[19:00:57.016] Received PubSub notification, asking Buildbucket for the build status
[19:00:57.041] Build:
{
"id": "8826160486986998881",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 7027,
"createdBy": "project:chromium",
"createTime": "2022-01-02T09:07:33.288513744Z",
"startTime": "2022-01-02T09:18:46.658456Z",
"endTime": "2022-01-02T19:00:56.645472692Z",
"updateTime": "2022-01-02T19:00:56.645472692Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "276d11cb3786768e7704b40f6da9c6bd7f65fe3b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:00:57.041] Invocation finished in 9h53m24.967769438s with status FAILED