[07:00:04.538] New invocation is queued and will start shortly
[07:00:05.787] Starting the invocation (attempt 1)
[07:00:05.823] Ignoring gitiles_ref tag without the buildset tag
[07:00:05.823] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:00:05.823] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:00:05.824] Buildbucket request:
{
"requestId": "9009717961230809344",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "rts-model-packager"
},
"properties": {
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9009717961230809344"
},
{
"key": "scheduler_job_id",
"value": "chromium/rts-model-packager"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:00:06.841] Scheduled build:
{
"id": "8844287899090341008",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "rts-model-packager"
},
"number": 148,
"createdBy": "project:chromium",
"createTime": "2021-06-16T07:00:05.942307Z",
"updateTime": "2021-06-16T07:00:06.636535Z",
"status": "SCHEDULED",
"input": {
}
}
[07:00:06.841] Task URL: https://cr-buildbucket.appspot.com/build/8844287899090341008
[07:00:06.842] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:2:0) after 9m54s
[07:10:00.889] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:2:0)
[07:10:00.947] Build status: SCHEDULED
[07:10:00.947] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:3:0) after 1m25s
[07:11:25.961] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:3:0)
[07:11:25.991] Build status: SCHEDULED
[07:11:25.991] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:4:0) after 7m28s
[07:18:54.099] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:4:0)
[07:18:54.134] Build status: SCHEDULED
[07:18:54.134] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:5:0) after 5m42s
[07:24:36.256] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:5:0)
[07:24:36.282] Build status: SCHEDULED
[07:24:36.282] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:6:0) after 4m15s
[07:28:51.366] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:6:0)
[07:28:51.494] Build status: SCHEDULED
[07:28:51.494] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:7:0) after 3m31s
[07:32:22.667] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:7:0)
[07:32:22.703] Build status: SCHEDULED
[07:32:22.703] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:8:0) after 7m1s
[07:39:23.868] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:8:0)
[07:39:23.900] Build status: SCHEDULED
[07:39:23.900] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:9:0) after 6m2s
[07:45:26.114] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:9:0)
[07:45:26.144] Build status: SCHEDULED
[07:45:26.144] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:10:0) after 2m8s
[07:47:34.246] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:10:0)
[07:47:34.279] Build status: SCHEDULED
[07:47:34.279] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:11:0) after 8m26s
[07:56:00.355] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:11:0)
[07:56:00.385] Build status: SCHEDULED
[07:56:00.385] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:12:0) after 3m49s
[07:59:49.545] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:12:0)
[07:59:49.570] Build status: SCHEDULED
[07:59:49.570] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:13:0) after 8m39s
[08:08:28.587] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:13:0)
[08:08:28.628] Build status: SCHEDULED
[08:08:28.628] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:14:0) after 7m1s
[08:15:29.649] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:14:0)
[08:15:29.679] Build status: SCHEDULED
[08:15:29.679] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:15:0) after 4m13s
[08:19:42.991] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:15:0)
[08:19:43.025] Build status: SCHEDULED
[08:19:43.025] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:16:0) after 5m49s
[08:25:32.190] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:16:0)
[08:25:32.223] Build status: SCHEDULED
[08:25:32.223] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:17:0) after 2m40s
[08:28:12.327] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:17:0)
[08:28:12.353] Build status: SCHEDULED
[08:28:12.353] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:18:0) after 7m11s
[08:35:23.963] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:18:0)
[08:35:23.991] Build status: SCHEDULED
[08:35:23.991] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:19:0) after 3m46s
[08:39:10.162] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:19:0)
[08:39:10.211] Build status: SCHEDULED
[08:39:10.211] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:20:0) after 8m8s
[08:47:18.239] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:20:0)
[08:47:18.267] Build status: SCHEDULED
[08:47:18.267] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:21:0) after 7m24s
[08:54:42.247] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:21:0)
[08:54:42.275] Build status: SCHEDULED
[08:54:42.275] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:22:0) after 5m4s
[08:59:46.551] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:22:0)
[08:59:46.585] Build status: SCHEDULED
[08:59:46.585] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:23:0) after 7m58s
[09:07:44.606] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:23:0)
[09:07:44.636] Build status: SCHEDULED
[09:07:44.636] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:24:0) after 9m49s
[09:17:33.655] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:24:0)
[09:17:33.682] Build status: SCHEDULED
[09:17:33.682] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:25:0) after 3m12s
[09:20:45.700] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:25:0)
[09:20:45.743] Build status: SCHEDULED
[09:20:45.743] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:26:0) after 8m31s
[09:29:16.764] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:26:0)
[09:29:16.798] Build status: SCHEDULED
[09:29:16.798] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:27:0) after 7m47s
[09:37:03.861] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:27:0)
[09:37:03.891] Build status: SCHEDULED
[09:37:03.891] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:28:0) after 2m51s
[09:39:54.924] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:28:0)
[09:39:54.957] Build status: SCHEDULED
[09:39:54.957] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:29:0) after 2m3s
[09:41:57.993] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:29:0)
[09:41:58.023] Build status: SCHEDULED
[09:41:58.023] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:30:0) after 6m59s
[09:48:57.515] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:30:0)
[09:48:57.541] Build status: SCHEDULED
[09:48:57.541] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:31:0) after 6m36s
[09:55:33.637] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:31:0)
[09:55:33.664] Build status: SCHEDULED
[09:55:33.664] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:32:0) after 5m49s
[10:01:22.747] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:32:0)
[10:01:22.777] Build status: SCHEDULED
[10:01:22.777] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:33:0) after 7m53s
[10:09:15.828] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:33:0)
[10:09:15.865] Build status: SCHEDULED
[10:09:15.865] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:34:0) after 3m23s
[10:12:38.881] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:34:0)
[10:12:38.909] Build status: SCHEDULED
[10:12:38.909] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:35:0) after 3m26s
[10:16:04.930] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:35:0)
[10:16:04.993] Build status: SCHEDULED
[10:16:04.993] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:36:0) after 3m42s
[10:19:47.019] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:36:0)
[10:19:47.048] Build status: SCHEDULED
[10:19:47.048] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:37:0) after 6m51s
[10:26:38.072] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:37:0)
[10:26:38.118] Build status: SCHEDULED
[10:26:38.118] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:38:0) after 5m15s
[10:31:53.136] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:38:0)
[10:31:53.169] Build status: SCHEDULED
[10:31:53.169] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:39:0) after 9m3s
[10:40:56.192] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:39:0)
[10:40:56.224] Build status: SCHEDULED
[10:40:56.224] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:40:0) after 3m51s
[10:44:47.245] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:40:0)
[10:44:47.273] Build status: SCHEDULED
[10:44:47.273] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:41:0) after 9m6s
[10:53:53.295] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:41:0)
[10:53:53.322] Build status: SCHEDULED
[10:53:53.322] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:42:0) after 2m45s
[10:56:38.342] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:42:0)
[10:56:38.378] Build status: SCHEDULED
[10:56:38.379] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:43:0) after 4m52s
[11:01:30.537] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:43:0)
[11:01:31.907] Build status: SCHEDULED
[11:01:31.907] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:44:0) after 3m26s
[11:04:57.931] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:44:0)
[11:04:57.966] Build status: SCHEDULED
[11:04:57.966] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:45:0) after 7m18s
[11:12:16.143] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:45:0)
[11:12:16.173] Build status: SCHEDULED
[11:12:16.173] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:46:0) after 5m47s
[11:18:03.203] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:46:0)
[11:18:03.236] Build status: SCHEDULED
[11:18:03.236] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:47:0) after 2m17s
[11:20:20.257] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:47:0)
[11:20:20.290] Build status: SCHEDULED
[11:20:20.290] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:48:0) after 5m8s
[11:25:28.447] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:48:0)
[11:25:28.482] Build status: SCHEDULED
[11:25:28.482] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:49:0) after 5m32s
[11:31:00.672] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:49:0)
[11:31:00.704] Build status: SCHEDULED
[11:31:00.704] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:50:0) after 8m26s
[11:39:26.730] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:50:0)
[11:39:26.766] Build status: SCHEDULED
[11:39:26.766] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:51:0) after 5m27s
[11:44:53.853] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:51:0)
[11:44:53.888] Build status: SCHEDULED
[11:44:53.888] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:52:0) after 5m32s
[11:50:26.049] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:52:0)
[11:50:26.076] Build status: SCHEDULED
[11:50:26.076] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:53:0) after 5m26s
[11:55:52.188] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:53:0)
[11:55:52.214] Build status: SCHEDULED
[11:55:52.214] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:54:0) after 2m29s
[11:58:21.232] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:54:0)
[11:58:21.273] Build status: SCHEDULED
[11:58:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:55:0) after 9m47s
[12:08:08.397] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:55:0)
[12:08:08.430] Build status: SCHEDULED
[12:08:08.430] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:56:0) after 8m49s
[12:16:58.288] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:56:0)
[12:16:58.317] Build status: SCHEDULED
[12:16:58.317] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:57:0) after 4m28s
[12:21:26.341] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:57:0)
[12:21:26.416] Build status: SCHEDULED
[12:21:26.416] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:58:0) after 2m20s
[12:23:46.441] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:58:0)
[12:23:46.476] Build status: SCHEDULED
[12:23:46.476] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:59:0) after 4m40s
[12:28:26.495] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:59:0)
[12:28:26.531] Build status: SCHEDULED
[12:28:26.531] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:60:0) after 4m44s
[12:33:10.558] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:60:0)
[12:33:10.590] Build status: SCHEDULED
[12:33:10.590] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:61:0) after 8m22s
[12:41:32.613] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:61:0)
[12:41:32.643] Build status: SCHEDULED
[12:41:32.643] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:62:0) after 4m4s
[12:45:36.682] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:62:0)
[12:45:36.710] Build status: SCHEDULED
[12:45:36.710] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:63:0) after 6m35s
[12:52:11.797] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:63:0)
[12:52:11.831] Build status: SCHEDULED
[12:52:11.831] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:64:0) after 6m45s
[12:58:56.857] Handling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:64:0)
[12:58:56.882] Build status: SCHEDULED
[12:58:56.882] Scheduling timer "check-buildbucket-build-status" (chromium/rts-model-packager:9009717961230809344:65:0) after 6m51s
[13:00:11.068] Received PubSub notification, asking Buildbucket for the build status
[13:00:11.126] Build:
{
"id": "8844287899090341008",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "rts-model-packager"
},
"number": 148,
"createdBy": "project:chromium",
"createTime": "2021-06-16T07:00:05.942307Z",
"endTime": "2021-06-16T13:00:09.914248Z",
"updateTime": "2021-06-16T13:00:10.670261Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"resourceExhaustion": {
},
"timeout": {
}
},
"input": {
}
}
[13:00:11.126] Invocation finished in 6h0m6.607768698s with status FAILED