[04:00:08.765] New invocation is queued and will start shortly
[04:00:09.955] Starting the invocation (attempt 1)
[04:00:09.995] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/91dd673765f357e323898192ed5bb34685ef68a8"
[04:00:09.995] Popped gitiles commit info from properties and tags
[04:00:09.995] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:09.995] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:09.995] Buildbucket request:
{
"requestId": "8937704693121448032",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "91dd673765f357e323898192ed5bb34685ef68a8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8937704693121448032"
},
{
"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"
}
}
[04:00:10.683] Scheduled build:
{
"id": "8772274631084759169",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 9504,
"createdBy": "project:chromium",
"createTime": "2023-08-20T04:00:10.080080242Z",
"updateTime": "2023-08-20T04:00:10.080080242Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "91dd673765f357e323898192ed5bb34685ef68a8",
"ref": "refs/heads/main"
}
}
}
[04:00:10.683] Task URL: https://cr-buildbucket.appspot.com/build/8772274631084759169
[04:00:10.683] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:2:0) after 7m22s
[04:00:11.717] Received PubSub notification, asking Buildbucket for the build status
[04:00:11.738] Build status: SCHEDULED
[04:00:38.951] Received PubSub notification, asking Buildbucket for the build status
[04:00:39.033] Build status: STARTED
[04:07:32.700] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:2:0)
[04:07:32.718] Build status: STARTED
[04:07:32.718] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:5:0) after 8m59s
[04:16:31.748] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:5:0)
[04:16:31.775] Build status: STARTED
[04:16:31.775] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:6:0) after 3m22s
[04:19:53.776] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:6:0)
[04:19:53.868] Build status: STARTED
[04:19:53.868] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:7:0) after 7m33s
[04:27:26.931] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:7:0)
[04:27:26.947] Build status: STARTED
[04:27:26.947] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:8:0) after 4m53s
[04:32:19.972] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:8:0)
[04:32:19.991] Build status: STARTED
[04:32:19.991] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:9:0) after 7m2s
[04:39:22.114] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:9:0)
[04:39:22.134] Build status: STARTED
[04:39:22.134] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:10:0) after 6m17s
[04:45:39.209] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:10:0)
[04:45:39.258] Build status: STARTED
[04:45:39.258] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:11:0) after 8m41s
[04:54:20.275] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:11:0)
[04:54:20.352] Build status: STARTED
[04:54:20.352] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:12:0) after 9m6s
[05:03:26.371] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:12:0)
[05:03:26.428] Build status: STARTED
[05:03:26.428] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:13:0) after 1m40s
[05:05:06.631] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:13:0)
[05:05:06.650] Build status: STARTED
[05:05:06.650] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:14:0) after 5m20s
[05:10:26.694] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:14:0)
[05:10:26.779] Build status: STARTED
[05:10:26.779] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:15:0) after 1m52s
[05:12:18.842] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:15:0)
[05:12:18.883] Build status: STARTED
[05:12:18.884] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:16:0) after 6m57s
[05:19:15.897] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:16:0)
[05:19:15.928] Build status: STARTED
[05:19:15.928] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:17:0) after 7m46s
[05:27:01.943] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:17:0)
[05:27:01.968] Build status: STARTED
[05:27:01.968] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:18:0) after 5m5s
[05:32:07.307] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:18:0)
[05:32:07.326] Build status: STARTED
[05:32:07.326] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:19:0) after 7m28s
[05:39:35.353] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:19:0)
[05:39:35.375] Build status: STARTED
[05:39:35.375] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:20:0) after 5m48s
[05:45:23.486] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:20:0)
[05:45:23.506] Build status: STARTED
[05:45:23.506] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:21:0) after 5m30s
[05:50:53.521] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:21:0)
[05:50:53.539] Build status: STARTED
[05:50:53.539] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:22:0) after 2m2s
[05:52:55.554] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:22:0)
[05:52:55.574] Build status: STARTED
[05:52:55.574] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:23:0) after 3m7s
[05:56:02.757] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:23:0)
[05:56:02.773] Build status: STARTED
[05:56:02.773] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:24:0) after 7m6s
[06:03:08.801] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:24:0)
[06:03:08.818] Build status: STARTED
[06:03:08.818] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:25:0) after 6m17s
[06:09:25.834] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:25:0)
[06:09:25.859] Build status: STARTED
[06:09:25.859] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:26:0) after 3m59s
[06:13:24.884] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:26:0)
[06:13:24.921] Build status: STARTED
[06:13:24.921] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:27:0) after 6m27s
[06:19:51.947] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:27:0)
[06:19:51.990] Build status: STARTED
[06:19:51.990] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:28:0) after 2m43s
[06:22:35.151] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:28:0)
[06:22:35.169] Build status: STARTED
[06:22:35.169] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:29:0) after 5m7s
[06:27:42.184] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:29:0)
[06:27:42.199] Build status: STARTED
[06:27:42.199] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:30:0) after 5m6s
[06:32:48.384] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:30:0)
[06:32:48.409] Build status: STARTED
[06:32:48.410] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:31:0) after 8m50s
[06:41:38.429] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:31:0)
[06:41:38.488] Build status: STARTED
[06:41:38.488] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:32:0) after 8m56s
[06:50:34.708] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:32:0)
[06:50:34.727] Build status: STARTED
[06:50:34.727] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:33:0) after 4m38s
[06:55:12.742] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:33:0)
[06:55:12.778] Build status: STARTED
[06:55:12.778] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:34:0) after 7m40s
[07:02:52.894] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:34:0)
[07:02:52.944] Build status: STARTED
[07:02:52.944] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:35:0) after 8m6s
[07:10:58.924] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:35:0)
[07:10:58.943] Build status: STARTED
[07:10:58.944] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:36:0) after 8m41s
[07:19:40.067] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:36:0)
[07:19:40.087] Build status: STARTED
[07:19:40.087] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:37:0) after 2m39s
[07:22:19.392] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:37:0)
[07:22:19.412] Build status: STARTED
[07:22:19.412] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:38:0) after 2m10s
[07:24:29.432] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:38:0)
[07:24:29.451] Build status: STARTED
[07:24:29.451] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:39:0) after 5m43s
[07:30:12.532] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:39:0)
[07:30:12.601] Build status: STARTED
[07:30:12.601] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:40:0) after 4m54s
[07:35:06.625] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:40:0)
[07:35:06.690] Build status: STARTED
[07:35:06.690] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:41:0) after 3m33s
[07:38:39.804] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:41:0)
[07:38:39.824] Build status: STARTED
[07:38:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:42:0) after 7m35s
[07:46:14.854] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:42:0)
[07:46:14.880] Build status: STARTED
[07:46:14.880] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:43:0) after 7m55s
[07:54:09.896] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:43:0)
[07:54:09.914] Build status: STARTED
[07:54:09.914] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:44:0) after 3m23s
[07:57:32.948] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:44:0)
[07:57:32.976] Build status: STARTED
[07:57:32.976] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:45:0) after 9m45s
[08:07:18.026] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:45:0)
[08:07:18.044] Build status: STARTED
[08:07:18.044] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:46:0) after 8m51s
[08:16:09.169] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:46:0)
[08:16:09.194] Build status: STARTED
[08:16:09.194] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:47:0) after 1m45s
[08:17:54.220] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:47:0)
[08:17:54.244] Build status: STARTED
[08:17:54.244] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:48:0) after 7m46s
[08:25:40.415] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:48:0)
[08:25:40.430] Build status: STARTED
[08:25:40.430] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:49:0) after 9m47s
[08:35:27.446] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:49:0)
[08:35:27.485] Build status: STARTED
[08:35:27.485] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:50:0) after 3m25s
[08:38:52.507] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:50:0)
[08:38:52.535] Build status: STARTED
[08:38:52.535] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:51:0) after 4m51s
[08:43:43.635] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:51:0)
[08:43:43.656] Build status: STARTED
[08:43:43.656] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:52:0) after 3m30s
[08:47:13.734] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:52:0)
[08:47:13.751] Build status: STARTED
[08:47:13.751] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:53:0) after 8m43s
[08:55:56.766] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:53:0)
[08:55:56.840] Build status: STARTED
[08:55:56.841] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:54:0) after 5m8s
[09:01:04.910] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:54:0)
[09:01:04.932] Build status: STARTED
[09:01:04.932] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:55:0) after 9m19s
[09:10:24.133] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:55:0)
[09:10:24.151] Build status: STARTED
[09:10:24.151] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:56:0) after 5m37s
[09:16:01.175] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:56:0)
[09:16:01.283] Build status: STARTED
[09:16:01.283] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:57:0) after 9m49s
[09:25:50.299] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:57:0)
[09:25:50.318] Build status: STARTED
[09:25:50.318] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:58:0) after 6m16s
[09:32:06.335] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:58:0)
[09:32:06.361] Build status: STARTED
[09:32:06.362] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:59:0) after 5m20s
[09:37:26.377] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:59:0)
[09:37:26.395] Build status: STARTED
[09:37:26.395] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:60:0) after 6m43s
[09:44:09.427] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:60:0)
[09:44:09.447] Build status: STARTED
[09:44:09.447] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:61:0) after 7m40s
[09:51:49.764] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:61:0)
[09:51:49.785] Build status: STARTED
[09:51:49.785] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:62:0) after 6m19s
[09:58:08.801] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:62:0)
[09:58:08.886] Build status: STARTED
[09:58:08.886] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:63:0) after 6m2s
[10:04:11.027] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:63:0)
[10:04:11.092] Build status: STARTED
[10:04:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:64:0) after 3m6s
[10:07:17.232] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:64:0)
[10:07:17.272] Build status: STARTED
[10:07:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:65:0) after 1m25s
[10:08:42.381] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:65:0)
[10:08:42.404] Build status: STARTED
[10:08:42.404] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:66:0) after 2m7s
[10:10:49.520] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:66:0)
[10:10:49.535] Build status: STARTED
[10:10:49.535] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:67:0) after 7m3s
[10:17:52.573] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:67:0)
[10:17:52.594] Build status: STARTED
[10:17:52.594] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:68:0) after 9m5s
[10:26:57.622] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:68:0)
[10:26:57.647] Build status: STARTED
[10:26:57.647] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:69:0) after 9m52s
[10:36:49.823] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:69:0)
[10:36:49.839] Build status: STARTED
[10:36:49.839] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:70:0) after 3m23s
[10:40:12.862] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:70:0)
[10:40:12.899] Build status: STARTED
[10:40:12.899] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:71:0) after 7m14s
[10:47:26.923] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:71:0)
[10:47:26.960] Build status: STARTED
[10:47:26.960] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:72:0) after 2m59s
[10:50:25.988] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:72:0)
[10:50:26.010] Build status: STARTED
[10:50:26.010] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:73:0) after 8m44s
[10:59:10.021] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:73:0)
[10:59:10.039] Build status: STARTED
[10:59:10.039] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:74:0) after 6m58s
[11:06:08.877] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:74:0)
[11:06:08.893] Build status: STARTED
[11:06:08.893] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:75:0) after 7m50s
[11:13:58.912] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:75:0)
[11:13:58.929] Build status: STARTED
[11:13:58.929] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:76:0) after 1m18s
[11:15:16.951] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:76:0)
[11:15:16.974] Build status: STARTED
[11:15:16.974] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:77:0) after 4m24s
[11:19:40.989] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:77:0)
[11:19:41.022] Build status: STARTED
[11:19:41.022] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:78:0) after 2m0s
[11:21:41.366] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:78:0)
[11:21:41.507] Build status: STARTED
[11:21:41.507] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:79:0) after 2m51s
[11:24:33.135] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:79:0)
[11:24:33.154] Build status: STARTED
[11:24:33.154] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:80:0) after 6m10s
[11:30:43.917] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:80:0)
[11:30:43.938] Build status: STARTED
[11:30:43.938] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:81:0) after 7m16s
[11:37:59.958] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:81:0)
[11:37:59.977] Build status: STARTED
[11:37:59.977] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:82:0) after 1m4s
[11:39:04.126] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:82:0)
[11:39:04.158] Build status: STARTED
[11:39:04.158] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:83:0) after 9m37s
[11:48:41.195] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:83:0)
[11:48:41.216] Build status: STARTED
[11:48:41.216] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:84:0) after 9m18s
[11:57:59.248] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:84:0)
[11:57:59.270] Build status: STARTED
[11:57:59.270] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:85:0) after 4m46s
[12:02:45.296] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:85:0)
[12:02:45.357] Build status: STARTED
[12:02:45.358] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:86:0) after 4m7s
[12:06:52.456] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:86:0)
[12:06:52.477] Build status: STARTED
[12:06:52.478] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:87:0) after 7m14s
[12:14:06.563] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:87:0)
[12:14:06.585] Build status: STARTED
[12:14:06.585] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:88:0) after 7m58s
[12:22:05.101] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:88:0)
[12:22:05.122] Build status: STARTED
[12:22:05.122] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:89:0) after 3m16s
[12:25:21.134] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:89:0)
[12:25:21.154] Build status: STARTED
[12:25:21.154] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:90:0) after 4m7s
[12:29:28.192] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:90:0)
[12:29:28.211] Build status: STARTED
[12:29:28.211] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:91:0) after 2m58s
[12:32:26.235] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:91:0)
[12:32:26.255] Build status: STARTED
[12:32:26.255] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:92:0) after 8m12s
[12:40:38.273] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:92:0)
[12:40:38.295] Build status: STARTED
[12:40:38.295] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:93:0) after 1m3s
[12:41:41.310] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:93:0)
[12:41:41.337] Build status: STARTED
[12:41:41.337] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:94:0) after 5m57s
[12:47:38.356] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:94:0)
[12:47:38.377] Build status: STARTED
[12:47:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:95:0) after 4m38s
[12:52:16.494] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:95:0)
[12:52:16.516] Build status: STARTED
[12:52:16.516] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:96:0) after 1m14s
[12:53:30.542] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:96:0)
[12:53:30.591] Build status: STARTED
[12:53:30.591] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:97:0) after 7m25s
[13:00:55.714] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:97:0)
[13:00:55.736] Build status: STARTED
[13:00:55.736] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:98:0) after 9m23s
[13:10:18.761] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:98:0)
[13:10:18.792] Build status: STARTED
[13:10:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:99:0) after 2m24s
[13:12:42.811] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:99:0)
[13:12:42.829] Build status: STARTED
[13:12:42.829] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:100:0) after 2m2s
[13:14:44.842] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:100:0)
[13:14:44.972] Build status: STARTED
[13:14:44.972] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:101:0) after 9m30s
[13:24:14.963] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:101:0)
[13:24:14.984] Build status: STARTED
[13:24:14.984] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:102:0) after 2m54s
[13:27:09.020] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:102:0)
[13:27:09.049] Build status: STARTED
[13:27:09.049] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:103:0) after 1m55s
[13:29:04.071] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:103:0)
[13:29:04.153] Build status: STARTED
[13:29:04.153] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:104:0) after 9m32s
[13:38:36.172] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:104:0)
[13:38:36.195] Build status: STARTED
[13:38:36.195] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:105:0) after 7m34s
[13:46:10.182] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:105:0)
[13:46:10.204] Build status: STARTED
[13:46:10.204] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:106:0) after 8m15s
[13:54:25.222] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:106:0)
[13:54:25.245] Build status: STARTED
[13:54:25.245] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:107:0) after 2m56s
[13:57:21.264] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:107:0)
[13:57:21.283] Build status: STARTED
[13:57:21.283] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:108:0) after 4m29s
[14:01:50.299] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:108:0)
[14:01:50.336] Build status: STARTED
[14:01:50.336] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:109:0) after 7m34s
[14:09:24.489] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:109:0)
[14:09:24.544] Build status: STARTED
[14:09:24.544] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:110:0) after 4m4s
[14:13:28.570] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:110:0)
[14:13:28.591] Build status: STARTED
[14:13:28.591] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:111:0) after 6m52s
[14:20:20.623] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:111:0)
[14:20:20.647] Build status: STARTED
[14:20:20.647] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:112:0) after 8m29s
[14:28:49.769] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:112:0)
[14:28:49.788] Build status: STARTED
[14:28:49.788] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:113:0) after 9m58s
[14:38:47.874] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:113:0)
[14:38:47.891] Build status: STARTED
[14:38:47.891] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:114:0) after 1m51s
[14:40:38.958] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:114:0)
[14:40:38.975] Build status: STARTED
[14:40:38.975] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:115:0) after 7m25s
[14:48:03.997] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:115:0)
[14:48:04.020] Build status: STARTED
[14:48:04.020] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:116:0) after 8m45s
[14:56:49.037] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:116:0)
[14:56:49.054] Build status: STARTED
[14:56:49.054] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:117:0) after 6m5s
[15:02:54.475] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:117:0)
[15:02:54.496] Build status: STARTED
[15:02:54.496] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:118:0) after 5m27s
[15:08:21.514] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:118:0)
[15:08:21.562] Build status: STARTED
[15:08:21.563] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:119:0) after 6m37s
[15:14:58.680] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:119:0)
[15:14:58.703] Build status: STARTED
[15:14:58.703] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:120:0) after 7m31s
[15:22:29.930] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:120:0)
[15:22:29.984] Build status: STARTED
[15:22:29.984] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:121:0) after 3m25s
[15:25:55.012] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:121:0)
[15:25:55.044] Build status: STARTED
[15:25:55.045] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:122:0) after 9m22s
[15:35:17.066] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:122:0)
[15:35:17.091] Build status: STARTED
[15:35:17.092] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:123:0) after 9m53s
[15:45:10.115] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:123:0)
[15:45:10.134] Build status: STARTED
[15:45:10.134] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:124:0) after 1m0s
[15:46:10.153] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:124:0)
[15:46:10.186] Build status: STARTED
[15:46:10.186] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:125:0) after 3m0s
[15:49:10.210] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:125:0)
[15:49:10.228] Build status: STARTED
[15:49:10.228] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:126:0) after 7m56s
[15:57:06.277] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:126:0)
[15:57:06.304] Build status: STARTED
[15:57:06.304] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:127:0) after 1m13s
[15:58:19.387] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:127:0)
[15:58:19.406] Build status: STARTED
[15:58:19.406] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:128:0) after 6m3s
[16:04:22.522] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:128:0)
[16:04:22.546] Build status: STARTED
[16:04:22.546] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:129:0) after 2m42s
[16:07:04.574] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:129:0)
[16:07:04.602] Build status: STARTED
[16:07:04.602] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:130:0) after 3m24s
[16:10:28.619] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:130:0)
[16:10:28.650] Build status: STARTED
[16:10:28.650] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:131:0) after 3m27s
[16:13:55.675] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:131:0)
[16:13:55.699] Build status: STARTED
[16:13:55.699] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:132:0) after 5m35s
[16:19:30.722] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:132:0)
[16:19:30.797] Build status: STARTED
[16:19:30.797] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:133:0) after 9m1s
[16:28:31.917] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:133:0)
[16:28:31.939] Build status: STARTED
[16:28:31.939] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:134:0) after 4m42s
[16:33:14.014] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:134:0)
[16:33:14.032] Build status: STARTED
[16:33:14.032] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:135:0) after 4m5s
[16:37:19.373] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:135:0)
[16:37:19.405] Build status: STARTED
[16:37:19.405] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:136:0) after 8m16s
[16:45:35.439] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:136:0)
[16:45:35.459] Build status: STARTED
[16:45:35.459] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:137:0) after 1m55s
[16:47:30.486] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:137:0)
[16:47:30.522] Build status: STARTED
[16:47:30.522] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:138:0) after 8m53s
[16:56:23.657] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:138:0)
[16:56:23.676] Build status: STARTED
[16:56:23.676] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:139:0) after 3m20s
[16:59:43.704] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:139:0)
[16:59:43.721] Build status: STARTED
[16:59:43.721] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:140:0) after 5m20s
[17:05:03.765] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:140:0)
[17:05:03.810] Build status: STARTED
[17:05:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:141:0) after 1m27s
[17:06:31.017] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:141:0)
[17:06:31.038] Build status: STARTED
[17:06:31.038] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:142:0) after 3m42s
[17:10:13.162] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:142:0)
[17:10:13.187] Build status: STARTED
[17:10:13.187] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8937704693121448032:143:0) after 9m48s
[17:10:22.832] Received PubSub notification, asking Buildbucket for the build status
[17:10:22.882] Build:
{
"id": "8772274631084759169",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 9504,
"createdBy": "project:chromium",
"createTime": "2023-08-20T04:00:10.080080242Z",
"startTime": "2023-08-20T04:00:38.485887Z",
"endTime": "2023-08-20T17:10:22.482751510Z",
"updateTime": "2023-08-20T17:10:22.482751510Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "91dd673765f357e323898192ed5bb34685ef68a8",
"ref": "refs/heads/main"
}
}
}
[17:10:22.882] Invocation finished in 13h10m14.127527763s with status SUCCEEDED