[07:12:31.086] New invocation is queued and will start shortly
[07:12:32.368] Starting the invocation (attempt 1)
[07:12:32.391] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5c3991933c1e451158613b1059f59992f780a00"
[07:12:32.391] Popped gitiles commit info from properties and tags
[07:12:32.391] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:12:32.391] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:12:32.391] Buildbucket request:
{
"requestId": "8890038585859287552",
"builder": {
"project": "chromium-m133",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8890038585859287552",
"job": "chromium-m133/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "efaf4a6b3d83b7a0c100c1016f2fb434db204025"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@efaf4a6b3d83b7a0c100c1016f2fb434db204025",
"title": "efaf4a6b3d83b7a0c100c1016f2fb434db204025",
"url": "https://chromium.googlesource.com/chromium/src/+/efaf4a6b3d83b7a0c100c1016f2fb434db204025"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "52454b224f006e1fa16df70b8dd2f984c5bfd78b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@52454b224f006e1fa16df70b8dd2f984c5bfd78b",
"title": "52454b224f006e1fa16df70b8dd2f984c5bfd78b",
"url": "https://chromium.googlesource.com/chromium/src/+/52454b224f006e1fa16df70b8dd2f984c5bfd78b"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "12e68e9270ec1232b12bdb97b89e150c0b4473ff"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@12e68e9270ec1232b12bdb97b89e150c0b4473ff",
"title": "12e68e9270ec1232b12bdb97b89e150c0b4473ff",
"url": "https://chromium.googlesource.com/chromium/src/+/12e68e9270ec1232b12bdb97b89e150c0b4473ff"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "368b8ca0c5c4f7b28f76ca2debf6a79d713b4299"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@368b8ca0c5c4f7b28f76ca2debf6a79d713b4299",
"title": "368b8ca0c5c4f7b28f76ca2debf6a79d713b4299",
"url": "https://chromium.googlesource.com/chromium/src/+/368b8ca0c5c4f7b28f76ca2debf6a79d713b4299"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "35db42ff6bfebd22eb5ac8015541232f164e0522"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@35db42ff6bfebd22eb5ac8015541232f164e0522",
"title": "35db42ff6bfebd22eb5ac8015541232f164e0522",
"url": "https://chromium.googlesource.com/chromium/src/+/35db42ff6bfebd22eb5ac8015541232f164e0522"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b5c3991933c1e451158613b1059f59992f780a00"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@b5c3991933c1e451158613b1059f59992f780a00",
"title": "b5c3991933c1e451158613b1059f59992f780a00",
"url": "https://chromium.googlesource.com/chromium/src/+/b5c3991933c1e451158613b1059f59992f780a00"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5c3991933c1e451158613b1059f59992f780a00",
"ref": "refs/branch-heads/6943"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8890038585859287552"
},
{
"key": "scheduler_job_id",
"value": "chromium-m133/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:12:33.197] Scheduled build:
{
"id": "8724608523709643521",
"builder": {
"project": "chromium-m133",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 113,
"createdBy": "project:chromium-m133",
"createTime": "2025-01-27T07:12:32.447440986Z",
"updateTime": "2025-01-27T07:12:32.447440986Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5c3991933c1e451158613b1059f59992f780a00",
"ref": "refs/branch-heads/6943"
}
}
}
[07:12:33.197] Task URL: https://cr-buildbucket.appspot.com/build/8724608523709643521
[07:12:33.197] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:2:0) after 5m35s
[07:12:33.754] Received PubSub notification, asking Buildbucket for the build status
[07:12:33.781] Build status: SCHEDULED
[07:18:08.310] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:2:0)
[07:18:08.386] Build status: SCHEDULED
[07:18:08.386] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:4:0) after 1m40s
[07:19:48.407] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:4:0)
[07:19:48.460] Build status: SCHEDULED
[07:19:48.460] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:5:0) after 6m2s
[07:25:50.542] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:5:0)
[07:25:50.578] Build status: SCHEDULED
[07:25:50.578] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:6:0) after 2m34s
[07:28:24.873] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:6:0)
[07:28:24.905] Build status: SCHEDULED
[07:28:24.905] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:7:0) after 9m21s
[07:37:45.962] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:7:0)
[07:37:45.984] Build status: SCHEDULED
[07:37:45.984] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:8:0) after 9m59s
[07:41:26.918] Received PubSub notification, asking Buildbucket for the build status
[07:41:26.943] Build status: STARTED
[07:47:45.444] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:8:0)
[07:47:45.479] Build status: STARTED
[07:47:45.479] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:10:0) after 9m44s
[07:57:29.538] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:10:0)
[07:57:29.578] Build status: STARTED
[07:57:29.578] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:11:0) after 6m58s
[08:04:27.602] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:11:0)
[08:04:27.638] Build status: STARTED
[08:04:27.638] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:12:0) after 4m5s
[08:08:32.686] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:12:0)
[08:08:32.710] Build status: STARTED
[08:08:32.710] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:13:0) after 8m0s
[08:16:32.826] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:13:0)
[08:16:32.848] Build status: STARTED
[08:16:32.848] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:14:0) after 7m15s
[08:23:47.963] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:14:0)
[08:23:47.978] Build status: STARTED
[08:23:47.978] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:15:0) after 3m41s
[08:27:29.040] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:15:0)
[08:27:29.066] Build status: STARTED
[08:27:29.066] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:16:0) after 6m12s
[08:33:41.201] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:16:0)
[08:33:41.220] Build status: STARTED
[08:33:41.220] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:17:0) after 6m57s
[08:40:38.443] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:17:0)
[08:40:38.470] Build status: STARTED
[08:40:38.471] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:18:0) after 1m31s
[08:42:09.489] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:18:0)
[08:42:09.509] Build status: STARTED
[08:42:09.509] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:19:0) after 2m34s
[08:44:43.489] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:19:0)
[08:44:43.519] Build status: STARTED
[08:44:43.520] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:20:0) after 2m21s
[08:47:04.546] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:20:0)
[08:47:04.565] Build status: STARTED
[08:47:04.566] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:21:0) after 6m5s
[08:53:09.717] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:21:0)
[08:53:09.821] Build status: STARTED
[08:53:09.821] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:22:0) after 5m10s
[08:58:20.553] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:22:0)
[08:58:20.573] Build status: STARTED
[08:58:20.573] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:23:0) after 9m37s
[09:07:57.807] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:23:0)
[09:07:57.827] Build status: STARTED
[09:07:57.827] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:24:0) after 6m28s
[09:14:25.946] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:24:0)
[09:14:25.968] Build status: STARTED
[09:14:25.968] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:25:0) after 9m58s
[09:24:24.119] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:25:0)
[09:24:24.142] Build status: STARTED
[09:24:24.142] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:26:0) after 4m49s
[09:29:13.158] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:26:0)
[09:29:13.186] Build status: STARTED
[09:29:13.186] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:27:0) after 1m50s
[09:31:03.214] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:27:0)
[09:31:03.243] Build status: STARTED
[09:31:03.243] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:28:0) after 9m41s
[09:40:44.375] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:28:0)
[09:40:44.441] Build status: STARTED
[09:40:44.441] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:29:0) after 7m10s
[09:47:54.467] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:29:0)
[09:47:54.485] Build status: STARTED
[09:47:54.485] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:30:0) after 5m5s
[09:52:59.504] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:30:0)
[09:52:59.532] Build status: STARTED
[09:52:59.532] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:31:0) after 8m12s
[10:01:11.551] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:31:0)
[10:01:11.603] Build status: STARTED
[10:01:11.603] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:32:0) after 5m11s
[10:06:23.452] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:32:0)
[10:06:23.482] Build status: STARTED
[10:06:23.482] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:33:0) after 4m41s
[10:11:04.744] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:33:0)
[10:11:04.763] Build status: STARTED
[10:11:04.763] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:34:0) after 2m33s
[10:13:37.786] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:34:0)
[10:13:37.978] Build status: STARTED
[10:13:37.978] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:35:0) after 9m2s
[10:22:40.037] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:35:0)
[10:22:40.059] Build status: STARTED
[10:22:40.059] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:36:0) after 8m53s
[10:31:33.121] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:36:0)
[10:31:33.143] Build status: STARTED
[10:31:33.143] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:37:0) after 7m28s
[10:39:01.276] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:37:0)
[10:39:01.305] Build status: STARTED
[10:39:01.305] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:38:0) after 2m25s
[10:41:26.479] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:38:0)
[10:41:26.504] Build status: STARTED
[10:41:26.504] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:39:0) after 5m5s
[10:46:31.573] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:39:0)
[10:46:31.593] Build status: STARTED
[10:46:31.594] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:40:0) after 6m4s
[10:52:35.942] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:40:0)
[10:52:35.958] Build status: STARTED
[10:52:35.958] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:41:0) after 7m26s
[11:00:02.054] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:41:0)
[11:00:02.086] Build status: STARTED
[11:00:02.086] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:42:0) after 2m12s
[11:02:14.113] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:42:0)
[11:02:14.132] Build status: STARTED
[11:02:14.132] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:43:0) after 8m50s
[11:11:04.155] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:43:0)
[11:11:04.172] Build status: STARTED
[11:11:04.172] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:44:0) after 5m15s
[11:16:19.241] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:44:0)
[11:16:19.280] Build status: STARTED
[11:16:19.280] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:45:0) after 2m14s
[11:18:33.301] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:45:0)
[11:18:33.415] Build status: STARTED
[11:18:33.415] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:46:0) after 9m9s
[11:27:42.434] Handling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:46:0)
[11:27:42.452] Build status: STARTED
[11:27:42.452] Scheduling timer "check-buildbucket-build-status" (chromium-m133/Android x64 Builder All Targets (dbg):8890038585859287552:47:0) after 2m39s
[11:27:50.171] Received PubSub notification, asking Buildbucket for the build status
[11:27:50.189] Build:
{
"id": "8724608523709643521",
"builder": {
"project": "chromium-m133",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 113,
"createdBy": "project:chromium-m133",
"createTime": "2025-01-27T07:12:32.447440986Z",
"startTime": "2025-01-27T07:40:31.466111003Z",
"endTime": "2025-01-27T11:27:48.286114065Z",
"updateTime": "2025-01-27T11:27:48.286114065Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b5c3991933c1e451158613b1059f59992f780a00",
"ref": "refs/branch-heads/6943"
}
}
}
[11:27:50.189] Invocation finished in 4h15m19.175693194s with status SUCCEEDED