[00:25:58.117] New invocation is queued and will start shortly
[00:25:59.214] Starting the invocation (attempt 1)
[00:25:59.262] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0566932157aa22162c5c99e95d40ea35c3b7a8c1"
[00:25:59.262] Popped gitiles commit info from properties and tags
[00:25:59.262] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:25:59.262] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:25:59.262] Buildbucket request:
{
"requestId": "8906552811562331728",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0566932157aa22162c5c99e95d40ea35c3b7a8c1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906552811562331728"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTAndroid (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:25:59.915] Scheduled build:
{
"id": "8741122749637776609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid (dbg)"
},
"number": 24834,
"createdBy": "project:chromium",
"createTime": "2024-07-29T00:25:59.324223463Z",
"updateTime": "2024-07-29T00:25:59.324223463Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0566932157aa22162c5c99e95d40ea35c3b7a8c1",
"ref": "refs/heads/main"
}
}
}
[00:25:59.915] Task URL: https://cr-buildbucket.appspot.com/build/8741122749637776609
[00:25:59.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:2:0) after 2m45s
[00:26:00.757] Received PubSub notification, asking Buildbucket for the build status
[00:26:00.775] Build status: SCHEDULED
[00:27:48.337] Received PubSub notification, asking Buildbucket for the build status
[00:27:48.361] Build status: STARTED
[00:28:44.938] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:2:0)
[00:28:44.966] Build status: STARTED
[00:28:44.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:5:0) after 3m40s
[00:32:25.050] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:5:0)
[00:32:25.118] Build status: STARTED
[00:32:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:6:0) after 4m27s
[00:36:52.155] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:6:0)
[00:36:52.179] Build status: STARTED
[00:36:52.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:7:0) after 7m2s
[00:43:54.208] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:7:0)
[00:43:54.225] Build status: STARTED
[00:43:54.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:8:0) after 1m46s
[00:45:40.243] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:8:0)
[00:45:40.263] Build status: STARTED
[00:45:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:9:0) after 2m15s
[00:47:55.376] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:9:0)
[00:47:55.450] Build status: STARTED
[00:47:55.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:10:0) after 5m11s
[00:53:06.464] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:10:0)
[00:53:06.481] Build status: STARTED
[00:53:06.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:11:0) after 2m45s
[00:55:51.499] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:11:0)
[00:55:51.520] Build status: STARTED
[00:55:51.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:12:0) after 4m54s
[01:00:45.562] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:12:0)
[01:00:45.579] Build status: STARTED
[01:00:45.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:13:0) after 6m7s
[01:06:52.596] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:13:0)
[01:06:52.614] Build status: STARTED
[01:06:52.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:14:0) after 2m40s
[01:09:32.730] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:14:0)
[01:09:32.747] Build status: STARTED
[01:09:32.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:15:0) after 1m1s
[01:10:33.742] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:15:0)
[01:10:33.776] Build status: STARTED
[01:10:33.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:16:0) after 6m23s
[01:16:56.792] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:16:0)
[01:16:56.816] Build status: STARTED
[01:16:56.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:17:0) after 5m49s
[01:22:45.954] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:17:0)
[01:22:46.132] Build status: STARTED
[01:22:46.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:18:0) after 5m23s
[01:28:09.147] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:18:0)
[01:28:09.164] Build status: STARTED
[01:28:09.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:19:0) after 3m7s
[01:31:16.166] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:19:0)
[01:31:16.192] Build status: STARTED
[01:31:16.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:20:0) after 8m12s
[01:39:28.324] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:20:0)
[01:39:28.415] Build status: STARTED
[01:39:28.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:21:0) after 9m36s
[01:49:04.614] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:21:0)
[01:49:04.631] Build status: STARTED
[01:49:04.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:22:0) after 7m24s
[01:56:28.765] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:22:0)
[01:56:28.786] Build status: STARTED
[01:56:28.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:23:0) after 4m21s
[02:00:49.807] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:23:0)
[02:00:49.861] Build status: STARTED
[02:00:49.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:24:0) after 9m28s
[02:10:18.008] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:24:0)
[02:10:18.026] Build status: STARTED
[02:10:18.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:25:0) after 7m18s
[02:17:36.076] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:25:0)
[02:17:36.094] Build status: STARTED
[02:17:36.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:26:0) after 3m40s
[02:21:16.142] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:26:0)
[02:21:16.178] Build status: STARTED
[02:21:16.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:27:0) after 6m11s
[02:27:27.293] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:27:0)
[02:27:27.317] Build status: STARTED
[02:27:27.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:28:0) after 7m23s
[02:34:50.342] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:28:0)
[02:34:50.361] Build status: STARTED
[02:34:50.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:29:0) after 3m45s
[02:38:35.483] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:29:0)
[02:38:35.525] Build status: STARTED
[02:38:35.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:30:0) after 2m10s
[02:40:45.548] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:30:0)
[02:40:45.567] Build status: STARTED
[02:40:45.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:31:0) after 1m45s
[02:42:30.615] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:31:0)
[02:42:30.633] Build status: STARTED
[02:42:30.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:32:0) after 1m11s
[02:43:41.647] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:32:0)
[02:43:41.670] Build status: STARTED
[02:43:41.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:33:0) after 6m28s
[02:50:09.925] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:33:0)
[02:50:09.989] Build status: STARTED
[02:50:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:34:0) after 2m46s
[02:52:55.970] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:34:0)
[02:52:55.997] Build status: STARTED
[02:52:55.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:35:0) after 9m59s
[03:02:55.184] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:35:0)
[03:02:55.213] Build status: STARTED
[03:02:55.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:36:0) after 6m22s
[03:09:17.229] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:36:0)
[03:09:17.247] Build status: STARTED
[03:09:17.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:37:0) after 3m15s
[03:12:32.264] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:37:0)
[03:12:32.287] Build status: STARTED
[03:12:32.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:38:0) after 4m29s
[03:17:01.411] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:38:0)
[03:17:01.438] Build status: STARTED
[03:17:01.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:39:0) after 5m6s
[03:22:07.585] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:39:0)
[03:22:07.605] Build status: STARTED
[03:22:07.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:40:0) after 8m3s
[03:30:10.681] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:40:0)
[03:30:10.704] Build status: STARTED
[03:30:10.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:41:0) after 6m19s
[03:36:29.720] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:41:0)
[03:36:29.745] Build status: STARTED
[03:36:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:42:0) after 3m51s
[03:40:20.970] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:42:0)
[03:40:20.993] Build status: STARTED
[03:40:20.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:43:0) after 4m56s
[03:45:17.085] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:43:0)
[03:45:17.103] Build status: STARTED
[03:45:17.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:44:0) after 5m54s
[03:51:11.226] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:44:0)
[03:51:11.246] Build status: STARTED
[03:51:11.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:45:0) after 7m43s
[03:58:54.272] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:45:0)
[03:58:54.286] Build status: STARTED
[03:58:54.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:46:0) after 6m41s
[04:05:35.426] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:46:0)
[04:05:35.445] Build status: STARTED
[04:05:35.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:47:0) after 9m41s
[04:15:16.471] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:47:0)
[04:15:16.486] Build status: STARTED
[04:15:16.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:48:0) after 5m13s
[04:20:29.514] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:48:0)
[04:20:29.601] Build status: STARTED
[04:20:29.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:49:0) after 2m58s
[04:23:27.691] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:49:0)
[04:23:27.708] Build status: STARTED
[04:23:27.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:50:0) after 2m52s
[04:26:19.735] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:50:0)
[04:26:19.754] Build status: STARTED
[04:26:19.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:51:0) after 3m19s
[04:29:38.810] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:51:0)
[04:29:38.849] Build status: STARTED
[04:29:38.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:52:0) after 5m44s
[04:35:22.868] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:52:0)
[04:35:22.886] Build status: STARTED
[04:35:22.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:53:0) after 1m49s
[04:37:11.950] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:53:0)
[04:37:11.965] Build status: STARTED
[04:37:11.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:54:0) after 6m0s
[04:43:12.108] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:54:0)
[04:43:12.125] Build status: STARTED
[04:43:12.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:55:0) after 6m42s
[04:49:54.480] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:55:0)
[04:49:54.498] Build status: STARTED
[04:49:54.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:56:0) after 5m53s
[04:55:48.043] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:56:0)
[04:55:48.104] Build status: STARTED
[04:55:48.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:57:0) after 6m4s
[05:01:52.126] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:57:0)
[05:01:52.146] Build status: STARTED
[05:01:52.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:58:0) after 6m55s
[05:08:47.295] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:58:0)
[05:08:47.341] Build status: STARTED
[05:08:47.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:59:0) after 8m36s
[05:17:23.570] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:59:0)
[05:17:23.587] Build status: STARTED
[05:17:23.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:60:0) after 6m48s
[05:24:11.641] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:60:0)
[05:24:11.666] Build status: STARTED
[05:24:11.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:61:0) after 2m33s
[05:26:44.654] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:61:0)
[05:26:44.723] Build status: STARTED
[05:26:44.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:62:0) after 8m27s
[05:35:11.751] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:62:0)
[05:35:11.781] Build status: STARTED
[05:35:11.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid (dbg):8906552811562331728:63:0) after 4m19s
[05:37:51.067] Received PubSub notification, asking Buildbucket for the build status
[05:37:51.086] Build:
{
"id": "8741122749637776609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid (dbg)"
},
"number": 24834,
"createdBy": "project:chromium",
"createTime": "2024-07-29T00:25:59.324223463Z",
"startTime": "2024-07-29T00:27:48.124734028Z",
"endTime": "2024-07-29T05:37:50.795270982Z",
"updateTime": "2024-07-29T05:37:50.795270982Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0566932157aa22162c5c99e95d40ea35c3b7a8c1",
"ref": "refs/heads/main"
}
}
}
[05:37:51.087] Invocation finished in 5h11m52.981257477s with status FAILED