[23:29:28.890] New invocation is queued and will start shortly
[23:29:30.566] Starting the invocation (attempt 1)
[23:29:30.598] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/db7251e6b8d1e72f066405fb612c9f2e1b8289a2"
[23:29:30.598] Popped gitiles commit info from properties and tags
[23:29:30.598] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:29:30.598] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:29:30.598] Buildbucket request:
{
"requestId": "8888708763035588880",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-16-x64-fyi-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db7251e6b8d1e72f066405fb612c9f2e1b8289a2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888708763035588880"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-16-x64-fyi-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:29:31.167] Scheduled build:
{
"id": "8723278700518654625",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-16-x64-fyi-rel"
},
"number": 870,
"createdBy": "project:chromium",
"createTime": "2025-02-10T23:29:30.669884757Z",
"updateTime": "2025-02-10T23:29:30.669884757Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db7251e6b8d1e72f066405fb612c9f2e1b8289a2",
"ref": "refs/heads/main"
}
}
}
[23:29:31.167] Task URL: https://cr-buildbucket.appspot.com/build/8723278700518654625
[23:29:31.167] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:2:0) after 2m41s
[23:29:32.131] Received PubSub notification, asking Buildbucket for the build status
[23:29:32.320] Build status: SCHEDULED
[23:30:31.915] Received PubSub notification, asking Buildbucket for the build status
[23:30:31.936] Build status: STARTED
[23:32:12.197] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:2:0)
[23:32:12.235] Build status: STARTED
[23:32:12.235] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:5:0) after 4m15s
[23:36:27.259] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:5:0)
[23:36:27.285] Build status: STARTED
[23:36:27.285] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:6:0) after 3m24s
[23:39:51.376] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:6:0)
[23:39:51.404] Build status: STARTED
[23:39:51.404] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:7:0) after 6m43s
[23:46:34.479] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:7:0)
[23:46:34.501] Build status: STARTED
[23:46:34.501] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:8:0) after 5m10s
[23:51:44.486] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:8:0)
[23:51:44.533] Build status: STARTED
[23:51:44.533] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:9:0) after 3m20s
[23:55:04.554] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:9:0)
[23:55:04.580] Build status: STARTED
[23:55:04.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:10:0) after 2m8s
[23:57:12.628] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:10:0)
[23:57:12.728] Build status: STARTED
[23:57:12.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:11:0) after 6m16s
[00:03:28.756] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:11:0)
[00:03:28.785] Build status: STARTED
[00:03:28.785] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:12:0) after 2m15s
[00:05:43.806] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:12:0)
[00:05:43.866] Build status: STARTED
[00:05:43.866] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:13:0) after 3m9s
[00:08:52.874] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:13:0)
[00:08:52.951] Build status: STARTED
[00:08:52.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:14:0) after 7m34s
[00:16:27.028] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:14:0)
[00:16:27.056] Build status: STARTED
[00:16:27.056] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:15:0) after 3m38s
[00:20:05.080] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:15:0)
[00:20:05.105] Build status: STARTED
[00:20:05.105] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:16:0) after 5m12s
[00:25:17.132] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:16:0)
[00:25:17.152] Build status: STARTED
[00:25:17.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:17:0) after 5m12s
[00:30:29.179] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:17:0)
[00:30:29.204] Build status: STARTED
[00:30:29.204] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:18:0) after 4m20s
[00:34:49.249] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:18:0)
[00:34:49.280] Build status: STARTED
[00:34:49.280] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:19:0) after 2m31s
[00:37:20.306] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:19:0)
[00:37:20.325] Build status: STARTED
[00:37:20.325] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:20:0) after 9m32s
[00:46:52.345] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:20:0)
[00:46:52.367] Build status: STARTED
[00:46:52.367] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:21:0) after 4m20s
[00:51:12.544] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:21:0)
[00:51:12.563] Build status: STARTED
[00:51:12.564] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:22:0) after 1m17s
[00:52:29.579] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:22:0)
[00:52:29.620] Build status: STARTED
[00:52:29.620] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:23:0) after 8m50s
[01:01:19.671] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:23:0)
[01:01:19.701] Build status: STARTED
[01:01:19.701] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:24:0) after 5m39s
[01:06:58.819] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:24:0)
[01:06:58.842] Build status: STARTED
[01:06:58.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:25:0) after 4m37s
[01:11:35.862] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:25:0)
[01:11:35.880] Build status: STARTED
[01:11:35.880] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:26:0) after 6m49s
[01:18:24.932] Handling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:26:0)
[01:18:24.951] Build status: STARTED
[01:18:24.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-16-x64-fyi-rel:8888708763035588880:27:0) after 7m3s
[01:20:21.238] Received PubSub notification, asking Buildbucket for the build status
[01:20:21.256] Build:
{
"id": "8723278700518654625",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-16-x64-fyi-rel"
},
"number": 870,
"createdBy": "project:chromium",
"createTime": "2025-02-10T23:29:30.669884757Z",
"startTime": "2025-02-10T23:30:31.647331693Z",
"endTime": "2025-02-11T01:20:20.731218003Z",
"updateTime": "2025-02-11T01:20:20.731218003Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db7251e6b8d1e72f066405fb612c9f2e1b8289a2",
"ref": "refs/heads/main"
}
}
}
[01:20:21.256] Invocation finished in 1h50m52.370932121s with status FAILED