[02:08:09.054] New invocation is queued and will start shortly
[02:08:10.770] Starting the invocation (attempt 1)
[02:08:10.810] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/14f5ebc46c254d2e4956f10c87e7ae7d8bc72969"
[02:08:10.810] Popped gitiles commit info from properties and tags
[02:08:10.810] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:08:10.811] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:08:10.811] Buildbucket request:
{
"requestId": "8964528441306278720",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-12-x64-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "14f5ebc46c254d2e4956f10c87e7ae7d8bc72969",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8964528441306278720"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-12-x64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:08:11.298] Scheduled build:
{
"id": "8799098378715044769",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-12-x64-rel"
},
"number": 2222,
"createdBy": "project:chromium",
"createTime": "2022-10-28T02:08:10.895939393Z",
"updateTime": "2022-10-28T02:08:10.895939393Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "14f5ebc46c254d2e4956f10c87e7ae7d8bc72969",
"ref": "refs/heads/main"
}
}
}
[02:08:11.298] Task URL: https://cr-buildbucket.appspot.com/build/8799098378715044769
[02:08:11.299] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:2:0) after 4m54s
[02:08:15.619] Received PubSub notification, asking Buildbucket for the build status
[02:08:15.650] Build status: STARTED
[02:13:05.436] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:2:0)
[02:13:05.485] Build status: STARTED
[02:13:05.485] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:4:0) after 8m52s
[02:21:57.513] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:4:0)
[02:21:57.567] Build status: STARTED
[02:21:57.567] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:5:0) after 8m55s
[02:30:52.932] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:5:0)
[02:30:52.952] Build status: STARTED
[02:30:52.953] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:6:0) after 4m15s
[02:35:07.985] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:6:0)
[02:35:08.012] Build status: STARTED
[02:35:08.013] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:7:0) after 5m30s
[02:40:38.034] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:7:0)
[02:40:38.065] Build status: STARTED
[02:40:38.065] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:8:0) after 7m26s
[02:48:04.094] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:8:0)
[02:48:04.142] Build status: STARTED
[02:48:04.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:9:0) after 1m23s
[02:49:27.165] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:9:0)
[02:49:27.225] Build status: STARTED
[02:49:27.225] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:10:0) after 7m10s
[02:56:37.491] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:10:0)
[02:56:37.516] Build status: STARTED
[02:56:37.517] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:11:0) after 4m54s
[03:01:31.504] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:11:0)
[03:01:31.525] Build status: STARTED
[03:01:31.525] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:12:0) after 7m23s
[03:08:54.559] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:12:0)
[03:08:54.582] Build status: STARTED
[03:08:54.582] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:13:0) after 4m9s
[03:13:03.615] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:13:0)
[03:13:03.637] Build status: STARTED
[03:13:03.637] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:14:0) after 5m33s
[03:18:37.310] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:14:0)
[03:18:37.334] Build status: STARTED
[03:18:37.334] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:15:0) after 4m53s
[03:23:30.603] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:15:0)
[03:23:30.631] Build status: STARTED
[03:23:30.631] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:16:0) after 4m40s
[03:28:10.661] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:16:0)
[03:28:10.728] Build status: STARTED
[03:28:10.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:17:0) after 9m25s
[03:37:36.359] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:17:0)
[03:37:36.384] Build status: STARTED
[03:37:36.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:18:0) after 7m23s
[03:44:59.504] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:18:0)
[03:44:59.541] Build status: STARTED
[03:44:59.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:19:0) after 7m24s
[03:52:23.637] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:19:0)
[03:52:23.662] Build status: STARTED
[03:52:23.662] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:20:0) after 3m8s
[03:55:31.715] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:20:0)
[03:55:31.737] Build status: STARTED
[03:55:31.737] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:21:0) after 3m35s
[03:59:06.820] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:21:0)
[03:59:06.845] Build status: STARTED
[03:59:06.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:22:0) after 3m59s
[04:03:06.025] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:22:0)
[04:03:06.094] Build status: STARTED
[04:03:06.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:23:0) after 7m58s
[04:11:04.114] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:23:0)
[04:11:04.227] Build status: STARTED
[04:11:04.227] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:24:0) after 7m39s
[04:18:43.353] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:24:0)
[04:18:43.380] Build status: STARTED
[04:18:43.380] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:25:0) after 2m38s
[04:21:21.409] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:25:0)
[04:21:21.431] Build status: STARTED
[04:21:21.431] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:26:0) after 9m36s
[04:30:57.464] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:26:0)
[04:30:57.487] Build status: STARTED
[04:30:57.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:27:0) after 2m45s
[04:33:42.510] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:27:0)
[04:33:42.533] Build status: STARTED
[04:33:42.533] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:28:0) after 3m59s
[04:37:41.735] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:28:0)
[04:37:41.759] Build status: STARTED
[04:37:41.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:29:0) after 2m36s
[04:40:17.914] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:29:0)
[04:40:17.938] Build status: STARTED
[04:40:17.938] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:30:0) after 5m51s
[04:46:09.051] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:30:0)
[04:46:09.075] Build status: STARTED
[04:46:09.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:31:0) after 7m55s
[04:54:04.107] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:31:0)
[04:54:04.134] Build status: STARTED
[04:54:04.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:32:0) after 6m51s
[05:00:55.228] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:32:0)
[05:00:55.253] Build status: STARTED
[05:00:55.253] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:33:0) after 2m7s
[05:03:02.378] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:33:0)
[05:03:02.441] Build status: STARTED
[05:03:02.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:34:0) after 7m17s
[05:10:19.578] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:34:0)
[05:10:19.614] Build status: STARTED
[05:10:19.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-rel:8964528441306278720:35:0) after 2m41s
[05:11:06.160] Received PubSub notification, asking Buildbucket for the build status
[05:11:06.187] Build:
{
"id": "8799098378715044769",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-12-x64-rel"
},
"number": 2222,
"createdBy": "project:chromium",
"createTime": "2022-10-28T02:08:10.895939393Z",
"startTime": "2022-10-28T02:08:14.383181Z",
"endTime": "2022-10-28T05:10:58.164078638Z",
"updateTime": "2022-10-28T05:10:58.164078638Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "14f5ebc46c254d2e4956f10c87e7ae7d8bc72969",
"ref": "refs/heads/main"
}
}
}
[05:11:06.187] Invocation finished in 3h2m57.146429667s with status FAILED