[18:14:40.162] New invocation is queued and will start shortly
[18:14:41.226] Starting the invocation (attempt 1)
[18:14:41.257] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c7708474233b685074b8c17fe5b3d7cd9d3fbb0f"
[18:14:41.257] Popped gitiles commit info from properties and tags
[18:14:41.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:14:41.257] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:14:41.257] Buildbucket request:
{
"requestId": "8888366181445536432",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c7708474233b685074b8c17fe5b3d7cd9d3fbb0f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888366181445536432"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTiOSDevice"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:14:41.756] Scheduled build:
{
"id": "8722936119573344913",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 36816,
"createdBy": "project:chromium",
"createTime": "2025-02-14T18:14:41.318639540Z",
"updateTime": "2025-02-14T18:14:41.318639540Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c7708474233b685074b8c17fe5b3d7cd9d3fbb0f",
"ref": "refs/heads/main"
}
}
}
[18:14:41.756] Task URL: https://cr-buildbucket.appspot.com/build/8722936119573344913
[18:14:41.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:2:0) after 6m21s
[18:14:42.745] Received PubSub notification, asking Buildbucket for the build status
[18:14:42.769] Build status: SCHEDULED
[18:14:46.413] Received PubSub notification, asking Buildbucket for the build status
[18:14:46.464] Build status: STARTED
[18:21:02.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:2:0)
[18:21:02.802] Build status: STARTED
[18:21:02.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:5:0) after 9m35s
[18:30:37.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:5:0)
[18:30:37.884] Build status: STARTED
[18:30:37.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:6:0) after 4m39s
[18:35:16.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:6:0)
[18:35:16.931] Build status: STARTED
[18:35:16.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:7:0) after 5m35s
[18:40:51.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:7:0)
[18:40:51.975] Build status: STARTED
[18:40:51.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:8:0) after 1m32s
[18:42:23.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:8:0)
[18:42:24.018] Build status: STARTED
[18:42:24.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:9:0) after 4m4s
[18:46:28.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:9:0)
[18:46:28.068] Build status: STARTED
[18:46:28.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:10:0) after 6m46s
[18:53:14.093] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:10:0)
[18:53:14.114] Build status: STARTED
[18:53:14.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:11:0) after 5m29s
[18:58:43.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:11:0)
[18:58:43.216] Build status: STARTED
[18:58:43.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:12:0) after 6m42s
[19:05:25.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:12:0)
[19:05:25.267] Build status: STARTED
[19:05:25.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:13:0) after 1m34s
[19:06:59.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:13:0)
[19:06:59.318] Build status: STARTED
[19:06:59.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:14:0) after 6m44s
[19:13:43.391] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:14:0)
[19:13:43.408] Build status: STARTED
[19:13:43.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:15:0) after 5m46s
[19:19:29.433] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:15:0)
[19:19:29.451] Build status: STARTED
[19:19:29.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:16:0) after 1m48s
[19:21:17.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:16:0)
[19:21:17.487] Build status: STARTED
[19:21:17.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:17:0) after 4m32s
[19:25:49.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:17:0)
[19:25:49.546] Build status: STARTED
[19:25:49.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:18:0) after 6m27s
[19:32:16.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:18:0)
[19:32:16.647] Build status: STARTED
[19:32:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:19:0) after 1m5s
[19:33:21.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:19:0)
[19:33:21.686] Build status: STARTED
[19:33:21.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:20:0) after 2m31s
[19:35:52.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:20:0)
[19:35:52.731] Build status: STARTED
[19:35:52.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:21:0) after 6m15s
[19:42:07.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:21:0)
[19:42:07.787] Build status: STARTED
[19:42:07.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:22:0) after 7m35s
[19:49:42.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:22:0)
[19:49:42.835] Build status: STARTED
[19:49:42.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:23:0) after 2m26s
[19:52:08.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:23:0)
[19:52:08.866] Build status: STARTED
[19:52:08.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:24:0) after 5m25s
[19:57:33.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:24:0)
[19:57:33.911] Build status: STARTED
[19:57:33.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:25:0) after 1m6s
[19:58:39.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:25:0)
[19:58:39.990] Build status: STARTED
[19:58:39.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:26:0) after 3m37s
[20:02:17.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:26:0)
[20:02:17.051] Build status: STARTED
[20:02:17.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:27:0) after 5m7s
[20:07:24.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:27:0)
[20:07:24.086] Build status: STARTED
[20:07:24.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:28:0) after 1m42s
[20:09:06.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:28:0)
[20:09:06.206] Build status: STARTED
[20:09:06.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:29:0) after 2m24s
[20:11:30.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:29:0)
[20:11:30.248] Build status: STARTED
[20:11:30.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:30:0) after 6m17s
[20:17:47.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:30:0)
[20:17:47.351] Build status: STARTED
[20:17:47.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:31:0) after 3m34s
[20:21:21.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:31:0)
[20:21:21.466] Build status: STARTED
[20:21:21.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:32:0) after 6m54s
[20:28:15.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:32:0)
[20:28:15.469] Build status: STARTED
[20:28:15.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:33:0) after 4m27s
[20:32:42.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:33:0)
[20:32:42.513] Build status: STARTED
[20:32:42.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:34:0) after 4m18s
[20:37:00.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:34:0)
[20:37:00.632] Build status: STARTED
[20:37:00.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:35:0) after 3m57s
[20:40:57.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:35:0)
[20:40:57.678] Build status: STARTED
[20:40:57.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:36:0) after 4m31s
[20:45:28.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:36:0)
[20:45:28.718] Build status: STARTED
[20:45:28.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:37:0) after 8m19s
[20:53:47.735] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:37:0)
[20:53:47.754] Build status: STARTED
[20:53:47.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:38:0) after 6m42s
[21:00:29.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:38:0)
[21:00:29.892] Build status: STARTED
[21:00:29.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:39:0) after 3m48s
[21:04:17.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:39:0)
[21:04:17.935] Build status: STARTED
[21:04:17.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:40:0) after 3m26s
[21:07:44.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:40:0)
[21:07:44.074] Build status: STARTED
[21:07:44.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:41:0) after 6m18s
[21:14:02.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:41:0)
[21:14:02.133] Build status: STARTED
[21:14:02.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:42:0) after 9m1s
[21:23:03.185] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:42:0)
[21:23:03.202] Build status: STARTED
[21:23:03.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:43:0) after 8m59s
[21:32:02.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:43:0)
[21:32:02.258] Build status: STARTED
[21:32:02.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:44:0) after 3m37s
[21:35:39.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:44:0)
[21:35:39.461] Build status: STARTED
[21:35:39.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:45:0) after 1m38s
[21:37:17.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:45:0)
[21:37:17.550] Build status: STARTED
[21:37:17.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:46:0) after 1m51s
[21:39:08.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:46:0)
[21:39:08.681] Build status: STARTED
[21:39:08.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:47:0) after 9m14s
[21:48:22.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:47:0)
[21:48:22.752] Build status: STARTED
[21:48:22.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:48:0) after 8m1s
[21:56:23.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:48:0)
[21:56:23.799] Build status: STARTED
[21:56:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:49:0) after 8m17s
[22:04:40.820] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:49:0)
[22:04:40.865] Build status: STARTED
[22:04:40.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:50:0) after 4m18s
[22:08:58.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:50:0)
[22:08:58.963] Build status: STARTED
[22:08:58.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8888366181445536432:51:0) after 8m45s
[22:13:59.461] Received PubSub notification, asking Buildbucket for the build status
[22:13:59.533] Build:
{
"id": "8722936119573344913",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 36816,
"createdBy": "project:chromium",
"createTime": "2025-02-14T18:14:41.318639540Z",
"startTime": "2025-02-14T18:14:46.119154031Z",
"endTime": "2025-02-14T22:13:59.137764316Z",
"updateTime": "2025-02-14T22:13:59.137764316Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c7708474233b685074b8c17fe5b3d7cd9d3fbb0f",
"ref": "refs/heads/main"
}
}
}
[22:13:59.533] Invocation finished in 3h59m19.383921941s with status FAILED