[12:30:28.401] New invocation is queued and will start shortly
[12:30:29.616] Starting the invocation (attempt 1)
[12:30:29.662] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/851ffc20577e4d65c8ad926236135944a967fb44"
[12:30:29.662] Popped gitiles commit info from properties and tags
[12:30:29.662] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:30:29.662] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:30:29.662] Buildbucket request:
{
"requestId": "8986051366167695488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "851ffc20577e4d65c8ad926236135944a967fb44",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8986051366167695488"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:30:30.227] Scheduled build:
{
"id": "8820621304083732561",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 27572,
"createdBy": "project:chromium",
"createTime": "2022-03-04T12:30:29.757223069Z",
"updateTime": "2022-03-04T12:30:29.757223069Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "851ffc20577e4d65c8ad926236135944a967fb44",
"ref": "refs/heads/main"
}
}
}
[12:30:30.227] Task URL: https://cr-buildbucket.appspot.com/build/8820621304083732561
[12:30:30.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:2:0) after 6m15s
[12:36:45.295] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:2:0)
[12:36:45.319] Build status: SCHEDULED
[12:36:45.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:3:0) after 6m41s
[12:43:26.345] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:3:0)
[12:43:26.397] Build status: SCHEDULED
[12:43:26.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:4:0) after 3m2s
[12:46:28.590] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:4:0)
[12:46:28.689] Build status: SCHEDULED
[12:46:28.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:5:0) after 5m10s
[12:51:39.504] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:5:0)
[12:51:39.530] Build status: SCHEDULED
[12:51:39.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:6:0) after 8m15s
[12:59:54.553] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:6:0)
[12:59:54.592] Build status: SCHEDULED
[12:59:54.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:7:0) after 8m13s
[13:08:07.774] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:7:0)
[13:08:07.801] Build status: SCHEDULED
[13:08:07.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:8:0) after 8m15s
[13:16:23.065] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:8:0)
[13:16:23.163] Build status: SCHEDULED
[13:16:23.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:9:0) after 3m22s
[13:19:45.191] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:9:0)
[13:19:45.268] Build status: SCHEDULED
[13:19:45.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:10:0) after 5m53s
[13:25:38.496] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:10:0)
[13:25:38.534] Build status: SCHEDULED
[13:25:38.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:11:0) after 5m37s
[13:31:15.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:11:0)
[13:31:15.633] Build status: SCHEDULED
[13:31:15.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:12:0) after 7m48s
[13:39:03.661] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:12:0)
[13:39:03.686] Build status: SCHEDULED
[13:39:03.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:13:0) after 8m30s
[13:47:33.712] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:13:0)
[13:47:33.734] Build status: SCHEDULED
[13:47:33.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:14:0) after 8m59s
[13:56:32.770] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:14:0)
[13:56:32.825] Build status: SCHEDULED
[13:56:32.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:15:0) after 1m30s
[13:58:03.012] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:15:0)
[13:58:03.041] Build status: SCHEDULED
[13:58:03.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:16:0) after 8m2s
[13:58:36.119] Received PubSub notification, asking Buildbucket for the build status
[13:58:36.139] Build status: STARTED
[14:06:05.063] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:16:0)
[14:06:05.096] Build status: STARTED
[14:06:05.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:18:0) after 3m42s
[14:09:47.121] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:18:0)
[14:09:47.148] Build status: STARTED
[14:09:47.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:19:0) after 1m37s
[14:11:24.146] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:19:0)
[14:11:24.166] Build status: STARTED
[14:11:24.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:20:0) after 5m35s
[14:16:59.296] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:20:0)
[14:16:59.315] Build status: STARTED
[14:16:59.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:21:0) after 8m41s
[14:25:40.403] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:21:0)
[14:25:40.479] Build status: STARTED
[14:25:40.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:22:0) after 4m3s
[14:29:43.504] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:22:0)
[14:29:43.526] Build status: STARTED
[14:29:43.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:23:0) after 2m14s
[14:31:57.592] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:23:0)
[14:31:57.616] Build status: STARTED
[14:31:57.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:24:0) after 1m5s
[14:33:02.869] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:24:0)
[14:33:02.954] Build status: STARTED
[14:33:02.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:25:0) after 8m43s
[14:41:46.235] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:25:0)
[14:41:46.258] Build status: STARTED
[14:41:46.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:26:0) after 5m32s
[14:47:18.321] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:26:0)
[14:47:18.343] Build status: STARTED
[14:47:18.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:27:0) after 2m55s
[14:50:13.449] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:27:0)
[14:50:13.472] Build status: STARTED
[14:50:13.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:28:0) after 8m17s
[14:58:30.495] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:28:0)
[14:58:30.516] Build status: STARTED
[14:58:30.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:29:0) after 1m9s
[14:59:39.629] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:29:0)
[14:59:39.700] Build status: STARTED
[14:59:39.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:30:0) after 2m27s
[15:02:06.683] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:30:0)
[15:02:06.705] Build status: STARTED
[15:02:06.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:31:0) after 8m50s
[15:10:56.861] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:31:0)
[15:10:56.882] Build status: STARTED
[15:10:56.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:32:0) after 1m56s
[15:12:53.048] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:32:0)
[15:12:53.077] Build status: STARTED
[15:12:53.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:33:0) after 6m17s
[15:19:10.104] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:33:0)
[15:19:10.154] Build status: STARTED
[15:19:10.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:34:0) after 9m47s
[15:28:57.192] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:34:0)
[15:28:57.234] Build status: STARTED
[15:28:57.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:35:0) after 1m33s
[15:30:30.372] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:35:0)
[15:30:30.421] Build status: STARTED
[15:30:30.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:36:0) after 5m57s
[15:36:27.746] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:36:0)
[15:36:27.767] Build status: STARTED
[15:36:27.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:37:0) after 8m0s
[15:44:27.824] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:37:0)
[15:44:27.866] Build status: STARTED
[15:44:27.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:38:0) after 3m57s
[15:48:25.024] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:38:0)
[15:48:25.066] Build status: STARTED
[15:48:25.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:39:0) after 9m15s
[15:57:40.107] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:39:0)
[15:57:40.172] Build status: STARTED
[15:57:40.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:40:0) after 5m39s
[16:03:19.210] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:40:0)
[16:03:19.229] Build status: STARTED
[16:03:19.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:41:0) after 3m22s
[16:06:41.252] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:41:0)
[16:06:41.277] Build status: STARTED
[16:06:41.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:42:0) after 2m51s
[16:09:32.398] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:42:0)
[16:09:32.423] Build status: STARTED
[16:09:32.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:43:0) after 1m34s
[16:11:06.452] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:43:0)
[16:11:06.522] Build status: STARTED
[16:11:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:44:0) after 6m46s
[16:17:52.546] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:44:0)
[16:17:52.590] Build status: STARTED
[16:17:52.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:45:0) after 2m5s
[16:19:57.784] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:45:0)
[16:19:57.827] Build status: STARTED
[16:19:57.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:46:0) after 2m35s
[16:22:32.865] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:46:0)
[16:22:32.889] Build status: STARTED
[16:22:32.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:47:0) after 2m15s
[16:24:47.911] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:47:0)
[16:24:47.947] Build status: STARTED
[16:24:47.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:48:0) after 9m57s
[16:34:44.985] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:48:0)
[16:34:45.019] Build status: STARTED
[16:34:45.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:49:0) after 9m58s
[16:44:43.363] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:49:0)
[16:44:43.391] Build status: STARTED
[16:44:43.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:50:0) after 6m26s
[16:51:09.656] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:50:0)
[16:51:09.680] Build status: STARTED
[16:51:09.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:51:0) after 5m55s
[16:57:04.707] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:51:0)
[16:57:04.735] Build status: STARTED
[16:57:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:52:0) after 2m0s
[16:59:04.848] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:52:0)
[16:59:04.878] Build status: STARTED
[16:59:04.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:53:0) after 4m48s
[17:03:53.014] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:53:0)
[17:03:53.061] Build status: STARTED
[17:03:53.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:54:0) after 1m28s
[17:05:21.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:54:0)
[17:05:21.158] Build status: STARTED
[17:05:21.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:55:0) after 9m11s
[17:14:32.593] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:55:0)
[17:14:32.647] Build status: STARTED
[17:14:32.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:56:0) after 8m22s
[17:22:54.672] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:56:0)
[17:22:54.714] Build status: STARTED
[17:22:54.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:57:0) after 5m30s
[17:28:24.748] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:57:0)
[17:28:24.782] Build status: STARTED
[17:28:24.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:58:0) after 9m24s
[17:37:48.812] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:58:0)
[17:37:48.833] Build status: STARTED
[17:37:48.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:59:0) after 6m40s
[17:44:29.105] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:59:0)
[17:44:29.154] Build status: STARTED
[17:44:29.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:60:0) after 3m4s
[17:47:33.287] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:60:0)
[17:47:33.314] Build status: STARTED
[17:47:33.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:61:0) after 3m15s
[17:50:48.452] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:61:0)
[17:50:48.475] Build status: STARTED
[17:50:48.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:62:0) after 1m52s
[17:52:40.500] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:62:0)
[17:52:40.520] Build status: STARTED
[17:52:40.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:63:0) after 9m47s
[18:02:27.712] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:63:0)
[18:02:27.752] Build status: STARTED
[18:02:27.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:64:0) after 4m46s
[18:07:13.956] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:64:0)
[18:07:13.984] Build status: STARTED
[18:07:13.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:65:0) after 4m32s
[18:11:46.008] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:65:0)
[18:11:46.059] Build status: STARTED
[18:11:46.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:66:0) after 5m0s
[18:16:46.087] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:66:0)
[18:16:46.124] Build status: STARTED
[18:16:46.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:67:0) after 5m13s
[18:21:59.285] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:67:0)
[18:21:59.309] Build status: STARTED
[18:21:59.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:68:0) after 8m15s
[18:30:14.507] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:68:0)
[18:30:14.542] Build status: STARTED
[18:30:14.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:69:0) after 2m10s
[18:32:24.574] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:69:0)
[18:32:24.608] Build status: STARTED
[18:32:24.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:70:0) after 7m17s
[18:39:41.740] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:70:0)
[18:39:41.774] Build status: STARTED
[18:39:41.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:71:0) after 9m53s
[18:49:34.882] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:71:0)
[18:49:34.905] Build status: STARTED
[18:49:34.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:72:0) after 1m39s
[18:51:13.933] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:72:0)
[18:51:13.958] Build status: STARTED
[18:51:13.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:73:0) after 3m50s
[18:55:04.081] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:73:0)
[18:55:04.108] Build status: STARTED
[18:55:04.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:74:0) after 8m33s
[19:03:37.211] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:74:0)
[19:03:37.237] Build status: STARTED
[19:03:37.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:75:0) after 9m2s
[19:12:39.412] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:75:0)
[19:12:39.446] Build status: STARTED
[19:12:39.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:76:0) after 8m47s
[19:21:26.479] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:76:0)
[19:21:26.557] Build status: STARTED
[19:21:26.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:77:0) after 2m1s
[19:23:27.586] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:77:0)
[19:23:27.617] Build status: STARTED
[19:23:27.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:78:0) after 5m26s
[19:28:53.852] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:78:0)
[19:28:53.905] Build status: STARTED
[19:28:53.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:79:0) after 3m43s
[19:32:37.031] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:79:0)
[19:32:37.050] Build status: STARTED
[19:32:37.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:80:0) after 6m30s
[19:39:07.091] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:80:0)
[19:39:07.122] Build status: STARTED
[19:39:07.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:81:0) after 4m26s
[19:43:33.463] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:81:0)
[19:43:33.491] Build status: STARTED
[19:43:33.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:82:0) after 1m24s
[19:44:58.236] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:82:0)
[19:44:58.257] Build status: STARTED
[19:44:58.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:83:0) after 7m53s
[19:52:51.560] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:83:0)
[19:52:51.584] Build status: STARTED
[19:52:51.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:84:0) after 1m44s
[19:54:35.848] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:84:0)
[19:54:35.873] Build status: STARTED
[19:54:35.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:85:0) after 6m25s
[20:01:01.312] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:85:0)
[20:01:01.335] Build status: STARTED
[20:01:01.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:86:0) after 6m18s
[20:07:19.941] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:86:0)
[20:07:19.977] Build status: STARTED
[20:07:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:87:0) after 7m43s
[20:15:03.368] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:87:0)
[20:15:03.462] Build status: STARTED
[20:15:03.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:88:0) after 6m28s
[20:21:31.908] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:88:0)
[20:21:31.933] Build status: STARTED
[20:21:31.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:89:0) after 1m34s
[20:23:06.046] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:89:0)
[20:23:06.083] Build status: STARTED
[20:23:06.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:90:0) after 9m50s
[20:32:56.182] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:90:0)
[20:32:56.210] Build status: STARTED
[20:32:56.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:91:0) after 2m40s
[20:35:36.386] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:91:0)
[20:35:36.409] Build status: STARTED
[20:35:36.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:92:0) after 4m3s
[20:39:39.575] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:92:0)
[20:39:39.598] Build status: STARTED
[20:39:39.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:93:0) after 5m41s
[20:45:20.633] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:93:0)
[20:45:20.662] Build status: STARTED
[20:45:20.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:94:0) after 4m17s
[20:49:37.777] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:94:0)
[20:49:37.801] Build status: STARTED
[20:49:37.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:95:0) after 1m9s
[20:50:47.120] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:95:0)
[20:50:47.155] Build status: STARTED
[20:50:47.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:96:0) after 9m12s
[20:59:59.301] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:96:0)
[20:59:59.326] Build status: STARTED
[20:59:59.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:97:0) after 5m45s
[21:05:44.578] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:97:0)
[21:05:44.616] Build status: STARTED
[21:05:44.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:98:0) after 4m15s
[21:09:59.653] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:98:0)
[21:09:59.676] Build status: STARTED
[21:09:59.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:99:0) after 3m9s
[21:13:08.809] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:99:0)
[21:13:08.849] Build status: STARTED
[21:13:08.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:100:0) after 7m45s
[21:20:53.981] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:100:0)
[21:20:54.009] Build status: STARTED
[21:20:54.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:101:0) after 8m28s
[21:29:22.149] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:101:0)
[21:29:22.183] Build status: STARTED
[21:29:22.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:102:0) after 5m40s
[21:35:02.314] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:102:0)
[21:35:02.341] Build status: STARTED
[21:35:02.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:103:0) after 3m0s
[21:38:02.686] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:103:0)
[21:38:02.741] Build status: STARTED
[21:38:02.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:104:0) after 2m44s
[21:40:46.783] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:104:0)
[21:40:46.844] Build status: STARTED
[21:40:46.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:105:0) after 6m23s
[21:47:09.944] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:105:0)
[21:47:09.965] Build status: STARTED
[21:47:09.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:106:0) after 6m55s
[21:54:04.945] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:106:0)
[21:54:04.980] Build status: STARTED
[21:54:04.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:107:0) after 3m26s
[21:57:31.277] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:107:0)
[21:57:31.308] Build status: STARTED
[21:57:31.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:108:0) after 1m29s
[21:59:00.475] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:108:0)
[21:59:00.509] Build status: STARTED
[21:59:00.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:109:0) after 3m16s
[22:02:16.645] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:109:0)
[22:02:16.780] Build status: STARTED
[22:02:16.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:110:0) after 8m53s
[22:11:09.833] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:110:0)
[22:11:09.864] Build status: STARTED
[22:11:09.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:111:0) after 2m17s
[22:13:27.041] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:111:0)
[22:13:27.066] Build status: STARTED
[22:13:27.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:112:0) after 5m0s
[22:18:27.453] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:112:0)
[22:18:27.498] Build status: STARTED
[22:18:27.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:113:0) after 7m14s
[22:25:41.626] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:113:0)
[22:25:41.696] Build status: STARTED
[22:25:41.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:114:0) after 6m50s
[22:32:31.803] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:114:0)
[22:32:31.833] Build status: STARTED
[22:32:31.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:115:0) after 5m51s
[22:38:23.569] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:115:0)
[22:38:23.591] Build status: STARTED
[22:38:23.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:116:0) after 6m6s
[22:44:29.697] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:116:0)
[22:44:29.722] Build status: STARTED
[22:44:29.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:117:0) after 9m26s
[22:53:56.255] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:117:0)
[22:53:56.284] Build status: STARTED
[22:53:56.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:118:0) after 2m19s
[22:56:15.608] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:118:0)
[22:56:15.633] Build status: STARTED
[22:56:15.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:119:0) after 8m59s
[23:05:14.666] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:119:0)
[23:05:14.689] Build status: STARTED
[23:05:14.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:120:0) after 3m20s
[23:08:34.722] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:120:0)
[23:08:34.745] Build status: STARTED
[23:08:34.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:121:0) after 2m15s
[23:10:50.094] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:121:0)
[23:10:50.117] Build status: STARTED
[23:10:50.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:122:0) after 1m18s
[23:12:08.153] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:122:0)
[23:12:08.177] Build status: STARTED
[23:12:08.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:123:0) after 6m31s
[23:18:39.263] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:123:0)
[23:18:39.300] Build status: STARTED
[23:18:39.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:124:0) after 9m45s
[23:28:24.345] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:124:0)
[23:28:24.369] Build status: STARTED
[23:28:24.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:125:0) after 2m19s
[23:30:43.441] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:125:0)
[23:30:43.487] Build status: STARTED
[23:30:43.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:126:0) after 8m21s
[23:39:04.634] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:126:0)
[23:39:04.677] Build status: STARTED
[23:39:04.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:127:0) after 2m58s
[23:42:03.050] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:127:0)
[23:42:03.079] Build status: STARTED
[23:42:03.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:128:0) after 6m58s
[23:49:01.456] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:128:0)
[23:49:01.478] Build status: STARTED
[23:49:01.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:129:0) after 4m36s
[23:53:37.649] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:129:0)
[23:53:37.674] Build status: STARTED
[23:53:37.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:130:0) after 2m11s
[23:55:48.711] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:130:0)
[23:55:48.744] Build status: STARTED
[23:55:48.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:131:0) after 3m2s
[23:58:50.773] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:131:0)
[23:58:50.797] Build status: STARTED
[23:58:50.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:132:0) after 1m49s
[00:00:39.972] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:132:0)
[00:00:39.995] Build status: STARTED
[00:00:39.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:133:0) after 8m12s
[00:08:52.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:133:0)
[00:08:52.085] Build status: STARTED
[00:08:52.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:134:0) after 5m8s
[00:14:00.120] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:134:0)
[00:14:00.152] Build status: STARTED
[00:14:00.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:135:0) after 8m52s
[00:22:52.550] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:135:0)
[00:22:52.581] Build status: STARTED
[00:22:52.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:136:0) after 7m20s
[00:30:12.638] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:136:0)
[00:30:12.659] Build status: STARTED
[00:30:12.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:137:0) after 4m25s
[00:34:37.871] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:137:0)
[00:34:37.915] Build status: STARTED
[00:34:37.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8986051366167695488:138:0) after 5m11s
[00:38:23.469] Received PubSub notification, asking Buildbucket for the build status
[00:38:23.490] Build:
{
"id": "8820621304083732561",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 27572,
"createdBy": "project:chromium",
"createTime": "2022-03-04T12:30:29.757223069Z",
"startTime": "2022-03-04T13:58:35.324283Z",
"endTime": "2022-03-05T00:38:22.896377210Z",
"updateTime": "2022-03-05T00:38:22.896377210Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "851ffc20577e4d65c8ad926236135944a967fb44",
"ref": "refs/heads/main"
}
}
}
[00:38:23.490] Invocation finished in 12h7m55.104077375s with status FAILED