[12:06:48.697] New invocation is queued and will start shortly
[12:06:51.398] Starting the invocation (attempt 1)
[12:06:51.428] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1a399c10a04dbeb9828f462875f53a7b120a6e8e"
[12:06:51.429] Popped gitiles commit info from properties and tags
[12:06:51.429] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:06:51.429] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:06:51.429] Buildbucket request:
{
"requestId": "8849160838600620048",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1a399c10a04dbeb9828f462875f53a7b120a6e8e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8849160838600620048"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTAndroid64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:06:51.937] Scheduled build:
{
"id": "8683730775006135025",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid64"
},
"number": 28392,
"createdBy": "project:chromium",
"createTime": "2026-04-23T12:06:51.498461008Z",
"updateTime": "2026-04-23T12:06:51.498461008Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1a399c10a04dbeb9828f462875f53a7b120a6e8e",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:06:51.937] Task URL: https://cr-buildbucket.appspot.com/build/8683730775006135025
[12:06:51.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:2:0) after 2m19s
[12:06:53.695] Received PubSub notification, asking Buildbucket for the build status
[12:06:53.711] Build status: SCHEDULED
[12:07:02.151] Received PubSub notification, asking Buildbucket for the build status
[12:07:02.171] Build status: STARTED
[12:09:11.214] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:2:0)
[12:09:11.240] Build status: STARTED
[12:09:11.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:5:0) after 3m47s
[12:12:58.349] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:5:0)
[12:12:58.364] Build status: STARTED
[12:12:58.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:6:0) after 8m32s
[12:21:30.382] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:6:0)
[12:21:30.552] Build status: STARTED
[12:21:30.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:7:0) after 1m40s
[12:23:10.550] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:7:0)
[12:23:10.568] Build status: STARTED
[12:23:10.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:8:0) after 6m30s
[12:29:40.581] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:8:0)
[12:29:40.599] Build status: STARTED
[12:29:40.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:9:0) after 1m27s
[12:31:07.785] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:9:0)
[12:31:07.802] Build status: STARTED
[12:31:07.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:10:0) after 3m49s
[12:34:56.845] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:10:0)
[12:34:56.859] Build status: STARTED
[12:34:56.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:11:0) after 9m28s
[12:44:24.893] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:11:0)
[12:44:24.910] Build status: STARTED
[12:44:24.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:12:0) after 4m56s
[12:49:20.923] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:12:0)
[12:49:20.959] Build status: STARTED
[12:49:20.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:13:0) after 1m8s
[12:50:29.001] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:13:0)
[12:50:29.017] Build status: STARTED
[12:50:29.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:14:0) after 9m0s
[12:59:29.122] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:14:0)
[12:59:29.136] Build status: STARTED
[12:59:29.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:15:0) after 4m26s
[13:03:55.168] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:15:0)
[13:03:55.204] Build status: STARTED
[13:03:55.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:16:0) after 6m54s
[13:10:49.557] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:16:0)
[13:10:49.577] Build status: STARTED
[13:10:49.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:17:0) after 4m8s
[13:14:57.593] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:17:0)
[13:14:57.610] Build status: STARTED
[13:14:57.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:18:0) after 5m2s
[13:19:59.718] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:18:0)
[13:19:59.741] Build status: STARTED
[13:19:59.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:19:0) after 3m21s
[13:23:20.833] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:19:0)
[13:23:20.850] Build status: STARTED
[13:23:20.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:20:0) after 3m8s
[13:26:28.903] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:20:0)
[13:26:28.933] Build status: STARTED
[13:26:28.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:21:0) after 5m15s
[13:31:43.998] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:21:0)
[13:31:44.038] Build status: STARTED
[13:31:44.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:22:0) after 8m6s
[13:39:50.069] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:22:0)
[13:39:50.093] Build status: STARTED
[13:39:50.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:23:0) after 5m37s
[13:45:27.193] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:23:0)
[13:45:27.210] Build status: STARTED
[13:45:27.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:24:0) after 7m5s
[13:52:32.225] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:24:0)
[13:52:32.282] Build status: STARTED
[13:52:32.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:25:0) after 5m56s
[13:58:28.301] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:25:0)
[13:58:28.319] Build status: STARTED
[13:58:28.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:26:0) after 5m56s
[14:04:24.315] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:26:0)
[14:04:24.382] Build status: STARTED
[14:04:24.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:27:0) after 4m1s
[14:08:25.429] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:27:0)
[14:08:25.447] Build status: STARTED
[14:08:25.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:28:0) after 4m53s
[14:13:18.461] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:28:0)
[14:13:18.482] Build status: STARTED
[14:13:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:29:0) after 5m13s
[14:18:31.498] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:29:0)
[14:18:31.521] Build status: STARTED
[14:18:31.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:30:0) after 4m44s
[14:23:15.560] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:30:0)
[14:23:15.592] Build status: STARTED
[14:23:15.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:31:0) after 7m5s
[14:30:20.708] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:31:0)
[14:30:20.727] Build status: STARTED
[14:30:20.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:32:0) after 8m40s
[14:39:00.836] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:32:0)
[14:39:00.863] Build status: STARTED
[14:39:00.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:33:0) after 3m24s
[14:42:24.929] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:33:0)
[14:42:24.951] Build status: STARTED
[14:42:24.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:34:0) after 4m7s
[14:46:32.025] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:34:0)
[14:46:32.046] Build status: STARTED
[14:46:32.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:35:0) after 1m55s
[14:48:27.099] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:35:0)
[14:48:27.118] Build status: STARTED
[14:48:27.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:36:0) after 8m15s
[14:56:42.157] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:36:0)
[14:56:42.186] Build status: STARTED
[14:56:42.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:37:0) after 7m14s
[15:03:56.289] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:37:0)
[15:03:56.308] Build status: STARTED
[15:03:56.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:38:0) after 7m20s
[15:11:16.533] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:38:0)
[15:11:16.569] Build status: STARTED
[15:11:16.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:39:0) after 4m6s
[15:15:22.553] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:39:0)
[15:15:22.583] Build status: STARTED
[15:15:22.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:40:0) after 7m9s
[15:22:31.561] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:40:0)
[15:22:31.582] Build status: STARTED
[15:22:31.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:41:0) after 7m43s
[15:30:14.734] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:41:0)
[15:30:14.757] Build status: STARTED
[15:30:14.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:42:0) after 4m9s
[15:34:23.768] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:42:0)
[15:34:23.786] Build status: STARTED
[15:34:23.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:43:0) after 3m50s
[15:38:13.825] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:43:0)
[15:38:13.843] Build status: STARTED
[15:38:13.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:44:0) after 4m30s
[15:42:44.219] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:44:0)
[15:42:44.247] Build status: STARTED
[15:42:44.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:45:0) after 8m13s
[15:50:57.352] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:45:0)
[15:50:57.376] Build status: STARTED
[15:50:57.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:46:0) after 4m50s
[15:55:47.396] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:46:0)
[15:55:47.419] Build status: STARTED
[15:55:47.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:47:0) after 4m30s
[16:00:17.483] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:47:0)
[16:00:17.508] Build status: STARTED
[16:00:17.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:48:0) after 5m46s
[16:06:03.622] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:48:0)
[16:06:03.646] Build status: STARTED
[16:06:03.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:49:0) after 6m54s
[16:12:57.754] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:49:0)
[16:12:57.770] Build status: STARTED
[16:12:57.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:50:0) after 1m6s
[16:14:03.795] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:50:0)
[16:14:03.815] Build status: STARTED
[16:14:03.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:51:0) after 3m50s
[16:17:53.827] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:51:0)
[16:17:53.846] Build status: STARTED
[16:17:53.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:52:0) after 5m17s
[16:23:10.913] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:52:0)
[16:23:10.939] Build status: STARTED
[16:23:10.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:53:0) after 1m23s
[16:24:34.135] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:53:0)
[16:24:34.159] Build status: STARTED
[16:24:34.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:54:0) after 8m59s
[16:33:33.308] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:54:0)
[16:33:33.333] Build status: STARTED
[16:33:33.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:55:0) after 3m21s
[16:36:54.359] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:55:0)
[16:36:54.386] Build status: STARTED
[16:36:54.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:56:0) after 8m10s
[16:45:04.399] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:56:0)
[16:45:04.435] Build status: STARTED
[16:45:04.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:57:0) after 7m40s
[16:52:44.599] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:57:0)
[16:52:44.614] Build status: STARTED
[16:52:44.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:58:0) after 6m31s
[16:59:15.741] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:58:0)
[16:59:15.757] Build status: STARTED
[16:59:15.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:59:0) after 3m59s
[17:03:14.839] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:59:0)
[17:03:14.856] Build status: STARTED
[17:03:14.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:60:0) after 8m54s
[17:12:08.952] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:60:0)
[17:12:08.975] Build status: STARTED
[17:12:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:61:0) after 3m43s
[17:15:52.151] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:61:0)
[17:15:52.223] Build status: STARTED
[17:15:52.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:62:0) after 8m54s
[17:24:46.333] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:62:0)
[17:24:46.351] Build status: STARTED
[17:24:46.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:63:0) after 3m7s
[17:27:53.368] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:63:0)
[17:27:53.386] Build status: STARTED
[17:27:53.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid64:8849160838600620048:64:0) after 5m9s
[17:29:43.030] Received PubSub notification, asking Buildbucket for the build status
[17:29:43.051] Build:
{
"id": "8683730775006135025",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid64"
},
"number": 28392,
"createdBy": "project:chromium",
"createTime": "2026-04-23T12:06:51.498461008Z",
"startTime": "2026-04-23T12:07:01.120466094Z",
"endTime": "2026-04-23T17:29:42.652552486Z",
"updateTime": "2026-04-23T17:29:42.652552486Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1a399c10a04dbeb9828f462875f53a7b120a6e8e",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:29:43.051] Invocation finished in 5h22m54.364472414s with status SUCCEEDED