[16:19:06.383] New invocation is queued and will start shortly
[16:19:09.811] Starting the invocation (attempt 1)
[16:19:09.845] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8a51d87cec5030b2c2291bfc7329054244e4e274"
[16:19:09.845] Popped gitiles commit info from properties and tags
[16:19:09.845] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:19:09.847] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:19:09.847] Buildbucket request:
{
"requestId": "8968914155168269088",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8a51d87cec5030b2c2291bfc7329054244e4e274",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8968914155168269088"
},
{
"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"
}
}
[16:19:10.585] Scheduled build:
{
"id": "8803484090818191601",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 8301,
"createdBy": "project:chromium",
"createTime": "2022-09-09T16:19:09.903168252Z",
"updateTime": "2022-09-09T16:19:09.903168252Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8a51d87cec5030b2c2291bfc7329054244e4e274",
"ref": "refs/heads/main"
}
}
}
[16:19:10.585] Task URL: https://cr-buildbucket.appspot.com/build/8803484090818191601
[16:19:10.585] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:2:0) after 8m45s
[16:27:55.615] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:2:0)
[16:27:55.647] Build status: SCHEDULED
[16:27:55.647] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:3:0) after 8m59s
[16:36:54.820] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:3:0)
[16:36:54.844] Build status: SCHEDULED
[16:36:54.844] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:4:0) after 6m50s
[16:43:44.849] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:4:0)
[16:43:44.884] Build status: SCHEDULED
[16:43:44.884] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:5:0) after 1m31s
[16:45:16.076] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:5:0)
[16:45:16.101] Build status: SCHEDULED
[16:45:16.101] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:6:0) after 3m57s
[16:49:13.467] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:6:0)
[16:49:13.486] Build status: SCHEDULED
[16:49:13.486] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:7:0) after 5m11s
[16:54:24.601] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:7:0)
[16:54:24.622] Build status: SCHEDULED
[16:54:24.622] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:8:0) after 7m53s
[17:02:17.641] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:8:0)
[17:02:17.674] Build status: SCHEDULED
[17:02:17.674] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:9:0) after 3m59s
[17:06:17.092] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:9:0)
[17:06:17.117] Build status: SCHEDULED
[17:06:17.117] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:10:0) after 9m44s
[17:16:01.150] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:10:0)
[17:16:01.177] Build status: SCHEDULED
[17:16:01.177] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:11:0) after 5m12s
[17:21:13.225] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:11:0)
[17:21:13.246] Build status: SCHEDULED
[17:21:13.246] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:12:0) after 2m0s
[17:23:13.293] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:12:0)
[17:23:13.312] Build status: SCHEDULED
[17:23:13.312] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:13:0) after 8m4s
[17:31:17.398] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:13:0)
[17:31:17.420] Build status: SCHEDULED
[17:31:17.420] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:14:0) after 5m46s
[17:37:03.442] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:14:0)
[17:37:03.467] Build status: SCHEDULED
[17:37:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:15:0) after 8m20s
[17:45:23.789] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:15:0)
[17:45:23.812] Build status: SCHEDULED
[17:45:23.812] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:16:0) after 1m47s
[17:47:10.846] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:16:0)
[17:47:10.877] Build status: SCHEDULED
[17:47:10.877] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:17:0) after 7m35s
[17:54:46.270] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:17:0)
[17:54:46.302] Build status: SCHEDULED
[17:54:46.302] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:18:0) after 5m17s
[18:00:03.341] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:18:0)
[18:00:03.368] Build status: SCHEDULED
[18:00:03.368] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:19:0) after 9m30s
[18:09:33.510] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:19:0)
[18:09:33.535] Build status: SCHEDULED
[18:09:33.535] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:20:0) after 6m18s
[18:15:51.962] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:20:0)
[18:15:51.997] Build status: SCHEDULED
[18:15:51.997] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:21:0) after 2m10s
[18:18:02.020] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:21:0)
[18:18:02.045] Build status: SCHEDULED
[18:18:02.045] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:22:0) after 7m19s
[18:25:21.135] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:22:0)
[18:25:21.163] Build status: SCHEDULED
[18:25:21.163] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:23:0) after 9m11s
[18:34:32.371] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:23:0)
[18:34:32.393] Build status: SCHEDULED
[18:34:32.393] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:24:0) after 9m3s
[18:43:35.827] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:24:0)
[18:43:35.845] Build status: SCHEDULED
[18:43:35.845] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:25:0) after 1m58s
[18:45:34.193] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:25:0)
[18:45:34.217] Build status: SCHEDULED
[18:45:34.218] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:26:0) after 6m50s
[18:52:24.898] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:26:0)
[18:52:24.921] Build status: SCHEDULED
[18:52:24.921] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:27:0) after 2m19s
[18:54:43.942] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:27:0)
[18:54:43.961] Build status: SCHEDULED
[18:54:43.961] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:28:0) after 8m5s
[19:02:49.093] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:28:0)
[19:02:49.118] Build status: SCHEDULED
[19:02:49.118] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:29:0) after 5m21s
[19:08:10.352] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:29:0)
[19:08:10.372] Build status: SCHEDULED
[19:08:10.372] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:30:0) after 8m4s
[19:16:14.397] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:30:0)
[19:16:14.434] Build status: SCHEDULED
[19:16:14.434] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:31:0) after 8m29s
[19:24:43.453] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:31:0)
[19:24:43.489] Build status: SCHEDULED
[19:24:43.489] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:32:0) after 3m20s
[19:28:03.510] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:32:0)
[19:28:03.533] Build status: SCHEDULED
[19:28:03.533] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:33:0) after 1m12s
[19:29:15.602] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:33:0)
[19:29:15.624] Build status: SCHEDULED
[19:29:15.624] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:34:0) after 7m58s
[19:37:13.613] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:34:0)
[19:37:13.637] Build status: SCHEDULED
[19:37:13.637] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:35:0) after 8m39s
[19:45:52.719] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:35:0)
[19:45:52.746] Build status: SCHEDULED
[19:45:52.746] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:36:0) after 4m34s
[19:50:26.862] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:36:0)
[19:50:26.884] Build status: SCHEDULED
[19:50:26.884] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:37:0) after 9m9s
[19:59:36.091] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:37:0)
[19:59:36.117] Build status: SCHEDULED
[19:59:36.117] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:38:0) after 6m49s
[20:06:25.408] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:38:0)
[20:06:25.438] Build status: SCHEDULED
[20:06:25.438] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:39:0) after 5m34s
[20:11:59.474] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:39:0)
[20:11:59.507] Build status: SCHEDULED
[20:11:59.507] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:40:0) after 2m29s
[20:14:28.527] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:40:0)
[20:14:28.551] Build status: SCHEDULED
[20:14:28.551] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:41:0) after 5m29s
[20:19:57.654] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:41:0)
[20:19:57.682] Build status: SCHEDULED
[20:19:57.682] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:42:0) after 5m18s
[20:25:15.940] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:42:0)
[20:25:15.960] Build status: SCHEDULED
[20:25:15.960] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:43:0) after 8m43s
[20:27:11.874] Received PubSub notification, asking Buildbucket for the build status
[20:27:11.899] Build status: STARTED
[20:33:59.190] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:43:0)
[20:33:59.224] Build status: STARTED
[20:33:59.224] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:45:0) after 9m39s
[20:43:38.331] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:45:0)
[20:43:38.359] Build status: STARTED
[20:43:38.359] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:46:0) after 2m51s
[20:46:29.394] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:46:0)
[20:46:29.417] Build status: STARTED
[20:46:29.417] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:47:0) after 5m4s
[20:51:33.437] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:47:0)
[20:51:33.464] Build status: STARTED
[20:51:33.464] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:48:0) after 8m41s
[21:00:14.508] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:48:0)
[21:00:14.537] Build status: STARTED
[21:00:14.538] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:49:0) after 2m1s
[21:02:15.631] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:49:0)
[21:02:15.657] Build status: STARTED
[21:02:15.657] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:50:0) after 4m37s
[21:06:52.651] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:50:0)
[21:06:52.672] Build status: STARTED
[21:06:52.672] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:51:0) after 5m37s
[21:12:29.902] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:51:0)
[21:12:29.926] Build status: STARTED
[21:12:29.926] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:52:0) after 7m43s
[21:20:12.991] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:52:0)
[21:20:13.011] Build status: STARTED
[21:20:13.011] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:53:0) after 6m0s
[21:26:13.190] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:53:0)
[21:26:13.211] Build status: STARTED
[21:26:13.211] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:54:0) after 9m2s
[21:35:15.450] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:54:0)
[21:35:15.473] Build status: STARTED
[21:35:15.473] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:55:0) after 5m42s
[21:40:57.636] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:55:0)
[21:40:57.660] Build status: STARTED
[21:40:57.660] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:56:0) after 7m45s
[21:48:42.694] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:56:0)
[21:48:42.726] Build status: STARTED
[21:48:42.726] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:57:0) after 4m24s
[21:53:06.818] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:57:0)
[21:53:06.886] Build status: STARTED
[21:53:06.886] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:58:0) after 4m13s
[21:57:20.080] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:58:0)
[21:57:20.101] Build status: STARTED
[21:57:20.102] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:59:0) after 2m3s
[21:59:23.203] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:59:0)
[21:59:23.228] Build status: STARTED
[21:59:23.228] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:60:0) after 7m1s
[22:06:24.451] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:60:0)
[22:06:24.488] Build status: STARTED
[22:06:24.488] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:61:0) after 8m41s
[22:15:05.778] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:61:0)
[22:15:05.799] Build status: STARTED
[22:15:05.799] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:62:0) after 6m8s
[22:21:13.868] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:62:0)
[22:21:13.896] Build status: STARTED
[22:21:13.897] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:63:0) after 3m57s
[22:25:10.957] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:63:0)
[22:25:10.982] Build status: STARTED
[22:25:10.982] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:64:0) after 8m29s
[22:33:40.051] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:64:0)
[22:33:40.078] Build status: STARTED
[22:33:40.079] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:65:0) after 5m41s
[22:39:21.443] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:65:0)
[22:39:21.519] Build status: STARTED
[22:39:21.519] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:66:0) after 5m2s
[22:44:24.054] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:66:0)
[22:44:24.077] Build status: STARTED
[22:44:24.078] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:67:0) after 8m11s
[22:52:35.202] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:67:0)
[22:52:35.225] Build status: STARTED
[22:52:35.225] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:68:0) after 2m12s
[22:54:47.476] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:68:0)
[22:54:47.499] Build status: STARTED
[22:54:47.499] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:69:0) after 8m27s
[23:03:14.932] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:69:0)
[23:03:14.956] Build status: STARTED
[23:03:14.956] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:70:0) after 2m55s
[23:06:10.150] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:70:0)
[23:06:10.174] Build status: STARTED
[23:06:10.175] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:71:0) after 7m30s
[23:13:40.255] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:71:0)
[23:13:40.276] Build status: STARTED
[23:13:40.276] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:72:0) after 9m28s
[23:23:08.366] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:72:0)
[23:23:08.390] Build status: STARTED
[23:23:08.390] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:73:0) after 2m3s
[23:25:11.530] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:73:0)
[23:25:11.562] Build status: STARTED
[23:25:11.562] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:74:0) after 6m18s
[23:31:29.789] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:74:0)
[23:31:29.818] Build status: STARTED
[23:31:29.818] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:75:0) after 6m32s
[23:38:01.898] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:75:0)
[23:38:01.992] Build status: STARTED
[23:38:01.992] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:76:0) after 4m2s
[23:42:04.012] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:76:0)
[23:42:04.054] Build status: STARTED
[23:42:04.054] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:77:0) after 9m11s
[23:51:15.106] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:77:0)
[23:51:15.130] Build status: STARTED
[23:51:15.130] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:78:0) after 6m58s
[23:58:13.415] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:78:0)
[23:58:13.441] Build status: STARTED
[23:58:13.441] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:79:0) after 7m39s
[00:05:53.278] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:79:0)
[00:05:53.303] Build status: STARTED
[00:05:53.303] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:80:0) after 1m30s
[00:07:23.639] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:80:0)
[00:07:23.662] Build status: STARTED
[00:07:23.662] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:81:0) after 7m22s
[00:14:45.748] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:81:0)
[00:14:45.850] Build status: STARTED
[00:14:45.850] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:82:0) after 6m19s
[00:21:04.922] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:82:0)
[00:21:04.949] Build status: STARTED
[00:21:04.949] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:83:0) after 1m55s
[00:22:59.958] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:83:0)
[00:22:59.983] Build status: STARTED
[00:22:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:84:0) after 2m51s
[00:25:50.987] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:84:0)
[00:25:51.023] Build status: STARTED
[00:25:51.024] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:85:0) after 1m6s
[00:26:57.116] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:85:0)
[00:26:57.137] Build status: STARTED
[00:26:57.137] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:86:0) after 3m9s
[00:30:06.383] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:86:0)
[00:30:06.422] Build status: STARTED
[00:30:06.422] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:87:0) after 3m6s
[00:33:12.579] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:87:0)
[00:33:12.599] Build status: STARTED
[00:33:12.599] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:88:0) after 5m48s
[00:39:00.618] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:88:0)
[00:39:00.639] Build status: STARTED
[00:39:00.639] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:89:0) after 8m0s
[00:47:00.657] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:89:0)
[00:47:00.681] Build status: STARTED
[00:47:00.681] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:90:0) after 2m51s
[00:49:51.710] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:90:0)
[00:49:51.732] Build status: STARTED
[00:49:51.732] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:91:0) after 2m7s
[00:51:58.820] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:91:0)
[00:51:58.847] Build status: STARTED
[00:51:58.848] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:92:0) after 9m58s
[01:01:56.910] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:92:0)
[01:01:56.938] Build status: STARTED
[01:01:56.938] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:93:0) after 2m16s
[01:04:13.070] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:93:0)
[01:04:13.104] Build status: STARTED
[01:04:13.104] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:94:0) after 8m34s
[01:12:47.335] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:94:0)
[01:12:47.359] Build status: STARTED
[01:12:47.359] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:95:0) after 7m4s
[01:19:51.632] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:95:0)
[01:19:51.657] Build status: STARTED
[01:19:51.657] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:96:0) after 2m48s
[01:22:39.678] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:96:0)
[01:22:39.704] Build status: STARTED
[01:22:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:97:0) after 4m51s
[01:27:30.761] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:97:0)
[01:27:30.794] Build status: STARTED
[01:27:30.794] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:98:0) after 8m30s
[01:36:01.102] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:98:0)
[01:36:01.134] Build status: STARTED
[01:36:01.134] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:99:0) after 8m13s
[01:44:14.396] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:99:0)
[01:44:14.425] Build status: STARTED
[01:44:14.425] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:100:0) after 9m1s
[01:53:15.687] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:100:0)
[01:53:15.709] Build status: STARTED
[01:53:15.709] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:101:0) after 4m5s
[01:57:20.731] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:101:0)
[01:57:20.751] Build status: STARTED
[01:57:20.751] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:102:0) after 3m55s
[02:01:15.775] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:102:0)
[02:01:15.801] Build status: STARTED
[02:01:15.801] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:103:0) after 3m59s
[02:05:14.915] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:103:0)
[02:05:14.936] Build status: STARTED
[02:05:14.936] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:104:0) after 1m20s
[02:06:35.039] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:104:0)
[02:06:35.067] Build status: STARTED
[02:06:35.068] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:105:0) after 3m3s
[02:09:38.186] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:105:0)
[02:09:38.211] Build status: STARTED
[02:09:38.211] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:106:0) after 4m44s
[02:14:22.301] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:106:0)
[02:14:22.362] Build status: STARTED
[02:14:22.362] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:107:0) after 4m13s
[02:18:35.503] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:107:0)
[02:18:35.527] Build status: STARTED
[02:18:35.527] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:108:0) after 8m3s
[02:26:38.651] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:108:0)
[02:26:38.676] Build status: STARTED
[02:26:38.676] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:109:0) after 6m58s
[02:33:36.708] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:109:0)
[02:33:36.732] Build status: STARTED
[02:33:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:110:0) after 1m40s
[02:35:17.165] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:110:0)
[02:35:17.190] Build status: STARTED
[02:35:17.190] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:111:0) after 6m2s
[02:41:19.248] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:111:0)
[02:41:19.273] Build status: STARTED
[02:41:19.273] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:112:0) after 6m6s
[02:47:25.402] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:112:0)
[02:47:25.425] Build status: STARTED
[02:47:25.425] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:113:0) after 2m19s
[02:49:44.510] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:113:0)
[02:49:44.535] Build status: STARTED
[02:49:44.535] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:114:0) after 7m16s
[02:57:00.985] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:114:0)
[02:57:01.008] Build status: STARTED
[02:57:01.008] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:115:0) after 3m59s
[03:01:00.024] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:115:0)
[03:01:00.055] Build status: STARTED
[03:01:00.055] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:116:0) after 9m11s
[03:10:11.185] Handling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:116:0)
[03:10:11.207] Build status: STARTED
[03:10:11.207] Scheduling timer "check-buildbucket-build-status" (chromium/mac-code-coverage:8968914155168269088:117:0) after 6m13s
[03:16:12.513] Received PubSub notification, asking Buildbucket for the build status
[03:16:12.536] Build:
{
"id": "8803484090818191601",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-code-coverage"
},
"number": 8301,
"createdBy": "project:chromium",
"createTime": "2022-09-09T16:19:09.903168252Z",
"startTime": "2022-09-09T20:27:11.374794Z",
"endTime": "2022-09-10T03:16:11.697037117Z",
"updateTime": "2022-09-10T03:16:11.697037117Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8a51d87cec5030b2c2291bfc7329054244e4e274",
"ref": "refs/heads/main"
}
}
}
[03:16:12.536] Invocation finished in 10h57m6.164860755s with status SUCCEEDED