[23:56:26.363] New invocation is queued and will start shortly
[23:56:27.445] Starting the invocation (attempt 1)
[23:56:27.520] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/781a33e938d4a83e890ce3359e5667d2cd8a15eb"
[23:56:27.520] Popped gitiles commit info from properties and tags
[23:56:27.520] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:56:27.520] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:56:27.520] Buildbucket request:
{
"requestId": "9016448789626798832",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "781a33e938d4a83e890ce3359e5667d2cd8a15eb",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9016448789626798832"
},
{
"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"
}
}
[23:56:28.417] Scheduled build:
{
"id": "8851018727599941680",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 3622,
"createdBy": "project:chromium",
"createTime": "2021-04-02T23:56:27.665132Z",
"updateTime": "2021-04-02T23:56:28.342592Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "781a33e938d4a83e890ce3359e5667d2cd8a15eb",
"ref": "refs/heads/master"
}
}
}
[23:56:28.417] Task URL: https://cr-buildbucket.appspot.com/build/8851018727599941680
[23:56:28.417] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:2:0) after 1m20s
[23:56:53.904] Received PubSub notification, asking Buildbucket for the build status
[23:56:54.004] Build status: STARTED
[23:57:48.438] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:2:0)
[23:57:48.479] Build status: STARTED
[23:57:48.479] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:4:0) after 8m7s
[00:05:55.553] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:4:0)
[00:05:55.912] Build status: STARTED
[00:05:55.912] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:5:0) after 8m1s
[00:13:57.174] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:5:0)
[00:13:57.199] Build status: STARTED
[00:13:57.199] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:6:0) after 3m11s
[00:17:08.230] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:6:0)
[00:17:08.260] Build status: STARTED
[00:17:08.260] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:7:0) after 6m54s
[00:24:02.399] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:7:0)
[00:24:02.436] Build status: STARTED
[00:24:02.436] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:8:0) after 7m38s
[00:31:40.511] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:8:0)
[00:31:40.540] Build status: STARTED
[00:31:40.540] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:9:0) after 9m34s
[00:41:14.778] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:9:0)
[00:41:14.801] Build status: STARTED
[00:41:14.801] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:10:0) after 7m7s
[00:48:21.936] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:10:0)
[00:48:21.969] Build status: STARTED
[00:48:21.969] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:11:0) after 4m8s
[00:52:30.009] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:11:0)
[00:52:30.204] Build status: STARTED
[00:52:30.204] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:12:0) after 2m25s
[00:54:55.275] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:12:0)
[00:54:55.305] Build status: STARTED
[00:54:55.305] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:13:0) after 5m22s
[01:00:17.412] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:13:0)
[01:00:17.466] Build status: STARTED
[01:00:17.466] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:14:0) after 1m10s
[01:01:27.603] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:14:0)
[01:01:27.641] Build status: STARTED
[01:01:27.641] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:15:0) after 6m19s
[01:07:46.703] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:15:0)
[01:07:46.762] Build status: STARTED
[01:07:46.762] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:16:0) after 5m42s
[01:13:28.746] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:16:0)
[01:13:28.807] Build status: STARTED
[01:13:28.807] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:17:0) after 6m48s
[01:20:16.939] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:17:0)
[01:20:17.062] Build status: STARTED
[01:20:17.062] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:18:0) after 8m23s
[01:28:40.124] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:18:0)
[01:28:40.153] Build status: STARTED
[01:28:40.153] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:19:0) after 4m15s
[01:32:55.177] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:19:0)
[01:32:55.205] Build status: STARTED
[01:32:55.205] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:20:0) after 1m37s
[01:34:32.491] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:20:0)
[01:34:32.522] Build status: STARTED
[01:34:32.522] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:21:0) after 8m28s
[01:43:00.553] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:21:0)
[01:43:00.623] Build status: STARTED
[01:43:00.623] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:22:0) after 3m17s
[01:46:17.725] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:22:0)
[01:46:17.801] Build status: STARTED
[01:46:17.801] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:23:0) after 2m44s
[01:49:01.862] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:23:0)
[01:49:01.908] Build status: STARTED
[01:49:01.908] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:24:0) after 3m33s
[01:52:35.048] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:24:0)
[01:52:35.100] Build status: STARTED
[01:52:35.100] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:25:0) after 1m10s
[01:53:45.148] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:25:0)
[01:53:45.184] Build status: STARTED
[01:53:45.185] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:26:0) after 4m18s
[01:58:03.207] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:26:0)
[01:58:03.244] Build status: STARTED
[01:58:03.244] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:27:0) after 2m50s
[02:00:53.405] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:27:0)
[02:00:53.435] Build status: STARTED
[02:00:53.435] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:28:0) after 4m17s
[02:05:10.591] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:28:0)
[02:05:10.617] Build status: STARTED
[02:05:10.617] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:29:0) after 7m29s
[02:12:39.671] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:29:0)
[02:12:39.707] Build status: STARTED
[02:12:39.707] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:30:0) after 6m1s
[02:18:40.813] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:30:0)
[02:18:40.842] Build status: STARTED
[02:18:40.842] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:31:0) after 8m0s
[02:26:40.874] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:31:0)
[02:26:40.903] Build status: STARTED
[02:26:40.903] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:32:0) after 6m16s
[02:32:56.937] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:32:0)
[02:32:56.986] Build status: STARTED
[02:32:56.986] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:33:0) after 8m4s
[02:41:01.491] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:33:0)
[02:41:01.517] Build status: STARTED
[02:41:01.518] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:34:0) after 9m44s
[02:50:45.739] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:34:0)
[02:50:45.774] Build status: STARTED
[02:50:45.774] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:35:0) after 5m11s
[02:55:56.846] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:35:0)
[02:55:56.886] Build status: STARTED
[02:55:56.886] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:36:0) after 3m37s
[02:59:33.905] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:36:0)
[02:59:33.970] Build status: STARTED
[02:59:33.970] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:37:0) after 5m57s
[03:05:31.003] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:37:0)
[03:05:31.031] Build status: STARTED
[03:05:31.031] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:38:0) after 8m40s
[03:14:11.296] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:38:0)
[03:14:11.330] Build status: STARTED
[03:14:11.330] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:39:0) after 6m4s
[03:20:15.737] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:39:0)
[03:20:15.767] Build status: STARTED
[03:20:15.767] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:40:0) after 5m5s
[03:25:21.237] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:40:0)
[03:25:21.274] Build status: STARTED
[03:25:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:41:0) after 7m8s
[03:32:29.709] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:41:0)
[03:32:29.766] Build status: STARTED
[03:32:29.766] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:42:0) after 6m32s
[03:39:02.048] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:42:0)
[03:39:02.086] Build status: STARTED
[03:39:02.086] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:43:0) after 1m45s
[03:40:47.231] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:43:0)
[03:40:47.259] Build status: STARTED
[03:40:47.259] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:44:0) after 7m10s
[03:47:57.592] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:44:0)
[03:47:57.620] Build status: STARTED
[03:47:57.620] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:45:0) after 4m59s
[03:52:56.873] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:45:0)
[03:52:56.944] Build status: STARTED
[03:52:56.944] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:46:0) after 7m25s
[04:00:22.137] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:46:0)
[04:00:22.175] Build status: STARTED
[04:00:22.175] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:47:0) after 1m10s
[04:01:32.619] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:47:0)
[04:01:32.932] Build status: STARTED
[04:01:32.932] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:48:0) after 6m27s
[04:08:00.070] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:48:0)
[04:08:00.098] Build status: STARTED
[04:08:00.098] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:49:0) after 2m23s
[04:10:23.556] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:49:0)
[04:10:23.591] Build status: STARTED
[04:10:23.591] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:50:0) after 5m4s
[04:15:27.613] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:50:0)
[04:15:27.666] Build status: STARTED
[04:15:27.666] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:51:0) after 2m12s
[04:17:39.835] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:51:0)
[04:17:39.872] Build status: STARTED
[04:17:39.872] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:52:0) after 4m31s
[04:22:10.968] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:52:0)
[04:22:11.012] Build status: STARTED
[04:22:11.012] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:53:0) after 2m14s
[04:24:25.017] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:53:0)
[04:24:25.046] Build status: STARTED
[04:24:25.046] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:54:0) after 9m14s
[04:33:39.075] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:54:0)
[04:33:39.122] Build status: STARTED
[04:33:39.122] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:55:0) after 8m40s
[04:42:19.162] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:55:0)
[04:42:19.188] Build status: STARTED
[04:42:19.188] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:56:0) after 1m35s
[04:43:54.236] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:56:0)
[04:43:54.265] Build status: STARTED
[04:43:54.265] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:57:0) after 5m56s
[04:49:50.288] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:57:0)
[04:49:50.320] Build status: STARTED
[04:49:50.320] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:58:0) after 6m8s
[04:55:58.351] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:58:0)
[04:55:58.386] Build status: STARTED
[04:55:58.386] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:59:0) after 2m33s
[04:58:31.415] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:59:0)
[04:58:31.447] Build status: STARTED
[04:58:31.447] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:60:0) after 4m44s
[05:03:15.501] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:60:0)
[05:03:15.599] Build status: STARTED
[05:03:15.599] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:61:0) after 9m8s
[05:12:23.648] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:61:0)
[05:12:23.679] Build status: STARTED
[05:12:23.679] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:62:0) after 8m28s
[05:20:51.707] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:62:0)
[05:20:51.732] Build status: STARTED
[05:20:51.732] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:63:0) after 3m40s
[05:24:31.767] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:63:0)
[05:24:31.821] Build status: STARTED
[05:24:31.821] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:64:0) after 4m46s
[05:29:17.846] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:64:0)
[05:29:17.872] Build status: STARTED
[05:29:17.872] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:65:0) after 4m15s
[05:33:32.897] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:65:0)
[05:33:32.925] Build status: STARTED
[05:33:32.925] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:66:0) after 2m35s
[05:36:07.980] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:66:0)
[05:36:08.017] Build status: STARTED
[05:36:08.017] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:67:0) after 1m26s
[05:37:34.049] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:67:0)
[05:37:34.080] Build status: STARTED
[05:37:34.080] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:68:0) after 9m45s
[05:47:19.205] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:68:0)
[05:47:19.236] Build status: STARTED
[05:47:19.236] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:69:0) after 3m24s
[05:50:43.261] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:69:0)
[05:50:43.414] Build status: STARTED
[05:50:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:70:0) after 1m21s
[05:52:04.462] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:70:0)
[05:52:04.493] Build status: STARTED
[05:52:04.493] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:71:0) after 7m14s
[05:59:18.607] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:71:0)
[05:59:18.636] Build status: STARTED
[05:59:18.636] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:72:0) after 6m32s
[06:05:50.946] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:72:0)
[06:05:50.977] Build status: STARTED
[06:05:50.977] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:73:0) after 8m23s
[06:14:14.028] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:73:0)
[06:14:14.068] Build status: STARTED
[06:14:14.068] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:74:0) after 6m43s
[06:20:57.293] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:74:0)
[06:20:57.325] Build status: STARTED
[06:20:57.325] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:75:0) after 3m5s
[06:24:02.602] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:75:0)
[06:24:02.634] Build status: STARTED
[06:24:02.634] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:76:0) after 6m40s
[06:30:42.693] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:76:0)
[06:30:42.729] Build status: STARTED
[06:30:42.729] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:77:0) after 7m43s
[06:38:25.888] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:77:0)
[06:38:25.919] Build status: STARTED
[06:38:25.919] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:78:0) after 3m52s
[06:42:17.951] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:78:0)
[06:42:17.981] Build status: STARTED
[06:42:17.981] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:79:0) after 8m37s
[06:50:55.083] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:79:0)
[06:50:55.106] Build status: STARTED
[06:50:55.106] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:80:0) after 7m29s
[06:58:24.329] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:80:0)
[06:58:24.353] Build status: STARTED
[06:58:24.353] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:81:0) after 4m4s
[07:02:28.387] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:81:0)
[07:02:28.416] Build status: STARTED
[07:02:28.416] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:82:0) after 3m5s
[07:05:33.438] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:82:0)
[07:05:33.468] Build status: STARTED
[07:05:33.468] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:83:0) after 8m50s
[07:14:23.490] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:83:0)
[07:14:23.538] Build status: STARTED
[07:14:23.538] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:84:0) after 3m45s
[07:18:08.664] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:84:0)
[07:18:08.693] Build status: STARTED
[07:18:08.693] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:85:0) after 2m25s
[07:20:33.865] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:85:0)
[07:20:33.893] Build status: STARTED
[07:20:33.893] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:86:0) after 5m28s
[07:26:01.954] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:86:0)
[07:26:02.014] Build status: STARTED
[07:26:02.014] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:87:0) after 8m2s
[07:34:04.117] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:87:0)
[07:34:04.145] Build status: STARTED
[07:34:04.146] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:88:0) after 3m18s
[07:37:22.497] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:88:0)
[07:37:22.532] Build status: STARTED
[07:37:22.532] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:89:0) after 2m17s
[07:39:39.557] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:89:0)
[07:39:39.586] Build status: STARTED
[07:39:39.586] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:90:0) after 6m55s
[07:46:34.810] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:90:0)
[07:46:34.836] Build status: STARTED
[07:46:34.836] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:91:0) after 5m11s
[07:51:45.858] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:91:0)
[07:51:45.891] Build status: STARTED
[07:51:45.891] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:92:0) after 2m11s
[07:53:57.116] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:92:0)
[07:53:57.146] Build status: STARTED
[07:53:57.146] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:93:0) after 2m16s
[07:56:13.260] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:93:0)
[07:56:13.290] Build status: STARTED
[07:56:13.290] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:94:0) after 2m56s
[07:59:09.319] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:94:0)
[07:59:09.346] Build status: STARTED
[07:59:09.346] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:95:0) after 2m59s
[08:02:08.374] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:95:0)
[08:02:08.435] Build status: STARTED
[08:02:08.435] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:96:0) after 6m7s
[08:08:15.459] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:96:0)
[08:08:15.492] Build status: STARTED
[08:08:15.492] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:97:0) after 7m39s
[08:15:54.746] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:97:0)
[08:15:54.786] Build status: STARTED
[08:15:54.786] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:98:0) after 5m38s
[08:21:32.810] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:98:0)
[08:21:32.842] Build status: STARTED
[08:21:32.842] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:99:0) after 6m29s
[08:28:01.881] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:99:0)
[08:28:01.926] Build status: STARTED
[08:28:01.926] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:100:0) after 8m16s
[08:36:17.950] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:100:0)
[08:36:17.979] Build status: STARTED
[08:36:17.979] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:101:0) after 8m6s
[08:44:23.965] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:101:0)
[08:44:23.997] Build status: STARTED
[08:44:23.997] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:102:0) after 6m51s
[08:51:15.043] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:102:0)
[08:51:15.072] Build status: STARTED
[08:51:15.072] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:103:0) after 5m27s
[08:56:42.173] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:103:0)
[08:56:42.207] Build status: STARTED
[08:56:42.207] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:104:0) after 9m34s
[09:06:16.258] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:104:0)
[09:06:16.300] Build status: STARTED
[09:06:16.300] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:105:0) after 3m38s
[09:09:54.324] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:105:0)
[09:09:54.381] Build status: STARTED
[09:09:54.381] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:106:0) after 2m47s
[09:12:41.523] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:106:0)
[09:12:41.552] Build status: STARTED
[09:12:41.552] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:107:0) after 7m23s
[09:20:04.760] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:107:0)
[09:20:04.818] Build status: STARTED
[09:20:04.818] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:108:0) after 7m36s
[09:27:40.847] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:108:0)
[09:27:40.884] Build status: STARTED
[09:27:40.884] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:109:0) after 9m25s
[09:37:05.912] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:109:0)
[09:37:05.952] Build status: STARTED
[09:37:05.952] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:110:0) after 5m23s
[09:42:28.985] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:110:0)
[09:42:29.011] Build status: STARTED
[09:42:29.011] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:111:0) after 8m56s
[09:51:25.038] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:111:0)
[09:51:25.091] Build status: STARTED
[09:51:25.091] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:112:0) after 1m25s
[09:52:50.131] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:112:0)
[09:52:50.161] Build status: STARTED
[09:52:50.161] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:113:0) after 6m59s
[09:59:49.188] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:113:0)
[09:59:49.216] Build status: STARTED
[09:59:49.216] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:114:0) after 9m3s
[10:08:52.248] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:114:0)
[10:08:52.417] Build status: STARTED
[10:08:52.417] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:115:0) after 1m19s
[10:10:11.445] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:115:0)
[10:10:11.472] Build status: STARTED
[10:10:11.472] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:116:0) after 3m58s
[10:14:09.556] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:116:0)
[10:14:09.614] Build status: STARTED
[10:14:09.614] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:117:0) after 5m11s
[10:19:20.642] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:117:0)
[10:19:20.667] Build status: STARTED
[10:19:20.667] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:118:0) after 8m27s
[10:27:47.710] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:118:0)
[10:27:47.764] Build status: STARTED
[10:27:47.764] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:119:0) after 7m44s
[10:35:31.801] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:119:0)
[10:35:31.828] Build status: STARTED
[10:35:31.828] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:120:0) after 3m5s
[10:38:36.874] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:120:0)
[10:38:36.898] Build status: STARTED
[10:38:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:121:0) after 6m33s
[10:45:09.928] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:121:0)
[10:45:09.963] Build status: STARTED
[10:45:09.963] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:122:0) after 6m38s
[10:51:47.991] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:122:0)
[10:51:48.025] Build status: STARTED
[10:51:48.025] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:123:0) after 5m46s
[10:57:34.741] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:123:0)
[10:57:34.776] Build status: STARTED
[10:57:34.776] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:9016448789626798832:124:0) after 7m37s
[10:59:06.958] Received PubSub notification, asking Buildbucket for the build status
[10:59:07.004] Build:
{
"id": "8851018727599941680",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 3622,
"createdBy": "project:chromium",
"createTime": "2021-04-02T23:56:27.665132Z",
"startTime": "2021-04-02T23:56:53.477340Z",
"endTime": "2021-04-03T10:59:05.920762702Z",
"updateTime": "2021-04-03T10:59:05.924116495Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "781a33e938d4a83e890ce3359e5667d2cd8a15eb",
"ref": "refs/heads/master"
}
}
}
[10:59:07.004] Invocation finished in 11h2m40.65550572s with status FAILED