[13:58:45.275] New invocation is queued and will start shortly
[13:58:46.343] Starting the invocation (attempt 1)
[13:58:46.390] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2fd73fb315913114dffefa6c0923c037b3c83c0b"
[13:58:46.390] Popped gitiles commit info from properties and tags
[13:58:46.390] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:58:46.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:58:46.390] Buildbucket request:
{
"requestId": "8989850884589976528",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2fd73fb315913114dffefa6c0923c037b3c83c0b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8989850884589976528"
},
{
"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"
}
}
[13:58:46.886] Scheduled build:
{
"id": "8824420822675490417",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 23790,
"createdBy": "project:chromium",
"createTime": "2022-01-21T13:58:46.461156386Z",
"updateTime": "2022-01-21T13:58:46.461156386Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2fd73fb315913114dffefa6c0923c037b3c83c0b",
"ref": "refs/heads/main"
}
}
}
[13:58:46.886] Task URL: https://cr-buildbucket.appspot.com/build/8824420822675490417
[13:58:46.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:2:0) after 1m3s
[13:59:50.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:2:0)
[13:59:50.048] Build status: SCHEDULED
[13:59:50.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:3:0) after 9m38s
[14:01:22.309] Received PubSub notification, asking Buildbucket for the build status
[14:01:22.343] Build status: STARTED
[14:09:28.071] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:3:0)
[14:09:28.092] Build status: STARTED
[14:09:28.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:5:0) after 9m12s
[14:18:40.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:5:0)
[14:18:40.209] Build status: STARTED
[14:18:40.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:6:0) after 5m8s
[14:23:48.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:6:0)
[14:23:48.364] Build status: STARTED
[14:23:48.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:7:0) after 7m21s
[14:31:09.483] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:7:0)
[14:31:09.513] Build status: STARTED
[14:31:09.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:8:0) after 5m17s
[14:36:26.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:8:0)
[14:36:26.597] Build status: STARTED
[14:36:26.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:9:0) after 2m52s
[14:39:18.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:9:0)
[14:39:18.691] Build status: STARTED
[14:39:18.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:10:0) after 2m54s
[14:42:12.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:10:0)
[14:42:12.762] Build status: STARTED
[14:42:12.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:11:0) after 7m33s
[14:49:45.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:11:0)
[14:49:45.820] Build status: STARTED
[14:49:45.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:12:0) after 3m32s
[14:53:17.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:12:0)
[14:53:17.866] Build status: STARTED
[14:53:17.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:13:0) after 2m15s
[14:55:32.904] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:13:0)
[14:55:32.937] Build status: STARTED
[14:55:32.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:14:0) after 9m38s
[15:05:11.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:14:0)
[15:05:11.211] Build status: STARTED
[15:05:11.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:15:0) after 6m58s
[15:12:09.358] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:15:0)
[15:12:09.384] Build status: STARTED
[15:12:09.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:16:0) after 7m37s
[15:19:46.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:16:0)
[15:19:46.513] Build status: STARTED
[15:19:46.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:17:0) after 6m21s
[15:26:07.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:17:0)
[15:26:07.513] Build status: STARTED
[15:26:07.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:18:0) after 7m36s
[15:33:43.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:18:0)
[15:33:43.738] Build status: STARTED
[15:33:43.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:19:0) after 9m26s
[15:43:09.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:19:0)
[15:43:09.896] Build status: STARTED
[15:43:09.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:20:0) after 6m14s
[15:49:23.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:20:0)
[15:49:24.008] Build status: STARTED
[15:49:24.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:21:0) after 4m28s
[15:53:52.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:21:0)
[15:53:52.066] Build status: STARTED
[15:53:52.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:22:0) after 2m36s
[15:56:28.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:22:0)
[15:56:28.351] Build status: STARTED
[15:56:28.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:23:0) after 9m4s
[16:05:32.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:23:0)
[16:05:32.669] Build status: STARTED
[16:05:32.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:24:0) after 1m45s
[16:07:17.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:24:0)
[16:07:17.860] Build status: STARTED
[16:07:17.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:25:0) after 1m51s
[16:09:08.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:25:0)
[16:09:08.951] Build status: STARTED
[16:09:08.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:26:0) after 4m50s
[16:13:58.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:26:0)
[16:13:59.007] Build status: STARTED
[16:13:59.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:27:0) after 2m42s
[16:16:41.106] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:27:0)
[16:16:41.200] Build status: STARTED
[16:16:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:28:0) after 1m14s
[16:17:55.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:28:0)
[16:17:55.317] Build status: STARTED
[16:17:55.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:29:0) after 5m7s
[16:23:02.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:29:0)
[16:23:02.466] Build status: STARTED
[16:23:02.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:30:0) after 4m39s
[16:27:41.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:30:0)
[16:27:41.648] Build status: STARTED
[16:27:41.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:31:0) after 4m11s
[16:31:52.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:31:0)
[16:31:52.694] Build status: STARTED
[16:31:52.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:32:0) after 6m55s
[16:38:47.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:32:0)
[16:38:47.759] Build status: STARTED
[16:38:47.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:33:0) after 3m37s
[16:42:24.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:33:0)
[16:42:24.997] Build status: STARTED
[16:42:24.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:34:0) after 3m39s
[16:46:04.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:34:0)
[16:46:04.276] Build status: STARTED
[16:46:04.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:35:0) after 9m17s
[16:55:21.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:35:0)
[16:55:21.329] Build status: STARTED
[16:55:21.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:36:0) after 6m50s
[17:02:11.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:36:0)
[17:02:11.797] Build status: STARTED
[17:02:11.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:37:0) after 3m30s
[17:05:41.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:37:0)
[17:05:42.007] Build status: STARTED
[17:05:42.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:38:0) after 8m14s
[17:13:56.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:38:0)
[17:13:56.182] Build status: STARTED
[17:13:56.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:39:0) after 4m8s
[17:18:04.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:39:0)
[17:18:04.447] Build status: STARTED
[17:18:04.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:40:0) after 4m25s
[17:22:29.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:40:0)
[17:22:29.507] Build status: STARTED
[17:22:29.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:41:0) after 5m36s
[17:28:05.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:41:0)
[17:28:05.765] Build status: STARTED
[17:28:05.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:42:0) after 6m4s
[17:34:09.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:42:0)
[17:34:10.037] Build status: STARTED
[17:34:10.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:43:0) after 9m18s
[17:43:28.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:43:0)
[17:43:28.320] Build status: STARTED
[17:43:28.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:44:0) after 9m21s
[17:52:49.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:44:0)
[17:52:49.619] Build status: STARTED
[17:52:49.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:45:0) after 2m27s
[17:55:16.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:45:0)
[17:55:16.932] Build status: STARTED
[17:55:16.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:46:0) after 9m25s
[18:04:42.091] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:46:0)
[18:04:42.110] Build status: STARTED
[18:04:42.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:47:0) after 2m0s
[18:06:42.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:47:0)
[18:06:42.887] Build status: STARTED
[18:06:42.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:48:0) after 1m15s
[18:07:57.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:48:0)
[18:07:57.931] Build status: STARTED
[18:07:57.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:49:0) after 7m27s
[18:15:25.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:49:0)
[18:15:25.028] Build status: STARTED
[18:15:25.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:50:0) after 5m19s
[18:20:44.164] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:50:0)
[18:20:44.187] Build status: STARTED
[18:20:44.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:51:0) after 2m15s
[18:22:59.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:51:0)
[18:22:59.715] Build status: STARTED
[18:22:59.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:52:0) after 2m42s
[18:25:41.735] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:52:0)
[18:25:41.769] Build status: STARTED
[18:25:41.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:53:0) after 9m20s
[18:35:02.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:53:0)
[18:35:02.054] Build status: STARTED
[18:35:02.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:54:0) after 5m21s
[18:40:23.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:54:0)
[18:40:23.102] Build status: STARTED
[18:40:23.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:55:0) after 2m39s
[18:43:02.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:55:0)
[18:43:02.169] Build status: STARTED
[18:43:02.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:56:0) after 9m35s
[18:52:37.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:56:0)
[18:52:37.238] Build status: STARTED
[18:52:37.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:57:0) after 3m46s
[18:56:23.299] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:57:0)
[18:56:23.636] Build status: STARTED
[18:56:23.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:58:0) after 8m19s
[19:04:42.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:58:0)
[19:04:42.868] Build status: STARTED
[19:04:42.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:59:0) after 6m14s
[19:10:56.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:59:0)
[19:10:56.970] Build status: STARTED
[19:10:56.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:60:0) after 7m3s
[19:18:00.106] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:60:0)
[19:18:00.127] Build status: STARTED
[19:18:00.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:61:0) after 6m31s
[19:24:31.276] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:61:0)
[19:24:31.305] Build status: STARTED
[19:24:31.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:62:0) after 8m28s
[19:32:59.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:62:0)
[19:32:59.465] Build status: STARTED
[19:32:59.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:63:0) after 7m24s
[19:40:23.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:63:0)
[19:40:23.590] Build status: STARTED
[19:40:23.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:64:0) after 4m40s
[19:45:03.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:64:0)
[19:45:03.733] Build status: STARTED
[19:45:03.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:65:0) after 7m4s
[19:52:07.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:65:0)
[19:52:07.838] Build status: STARTED
[19:52:07.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:66:0) after 2m9s
[19:54:16.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:66:0)
[19:54:16.936] Build status: STARTED
[19:54:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:67:0) after 6m50s
[20:01:07.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:67:0)
[20:01:07.321] Build status: STARTED
[20:01:07.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:68:0) after 5m46s
[20:06:53.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:68:0)
[20:06:53.384] Build status: STARTED
[20:06:53.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:69:0) after 6m38s
[20:13:31.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:69:0)
[20:13:31.437] Build status: STARTED
[20:13:31.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:70:0) after 7m29s
[20:21:00.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:70:0)
[20:21:00.655] Build status: STARTED
[20:21:00.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:71:0) after 9m30s
[20:30:30.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:71:0)
[20:30:30.734] Build status: STARTED
[20:30:30.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:72:0) after 4m12s
[20:34:42.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:72:0)
[20:34:42.895] Build status: STARTED
[20:34:42.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:73:0) after 4m35s
[20:39:18.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:73:0)
[20:39:18.102] Build status: STARTED
[20:39:18.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:74:0) after 1m56s
[20:41:14.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:74:0)
[20:41:14.162] Build status: STARTED
[20:41:14.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:75:0) after 3m41s
[20:44:55.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:75:0)
[20:44:55.233] Build status: STARTED
[20:44:55.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:76:0) after 1m49s
[20:46:44.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:76:0)
[20:46:44.271] Build status: STARTED
[20:46:44.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:77:0) after 7m38s
[20:54:22.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:77:0)
[20:54:22.316] Build status: STARTED
[20:54:22.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:78:0) after 4m4s
[20:58:26.344] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:78:0)
[20:58:26.386] Build status: STARTED
[20:58:26.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:79:0) after 2m31s
[21:00:57.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:79:0)
[21:00:57.434] Build status: STARTED
[21:00:57.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:80:0) after 8m13s
[21:09:10.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:80:0)
[21:09:10.546] Build status: STARTED
[21:09:10.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:81:0) after 1m42s
[21:10:52.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:81:0)
[21:10:52.606] Build status: STARTED
[21:10:52.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:82:0) after 1m15s
[21:12:07.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:82:0)
[21:12:07.685] Build status: STARTED
[21:12:07.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:83:0) after 3m48s
[21:15:55.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:83:0)
[21:15:55.729] Build status: STARTED
[21:15:55.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:84:0) after 5m12s
[21:21:07.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:84:0)
[21:21:07.803] Build status: STARTED
[21:21:07.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:85:0) after 3m24s
[21:24:32.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:85:0)
[21:24:32.085] Build status: STARTED
[21:24:32.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:86:0) after 7m5s
[21:31:37.348] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:86:0)
[21:31:37.368] Build status: STARTED
[21:31:37.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:87:0) after 4m10s
[21:35:47.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:87:0)
[21:35:47.756] Build status: STARTED
[21:35:47.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:88:0) after 1m40s
[21:37:27.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:88:0)
[21:37:27.772] Build status: STARTED
[21:37:27.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:89:0) after 8m11s
[21:45:38.902] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:89:0)
[21:45:38.922] Build status: STARTED
[21:45:38.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:90:0) after 8m32s
[21:54:10.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:90:0)
[21:54:10.993] Build status: STARTED
[21:54:10.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:91:0) after 7m18s
[22:01:29.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:91:0)
[22:01:29.315] Build status: STARTED
[22:01:29.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:92:0) after 6m18s
[22:07:47.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:92:0)
[22:07:47.371] Build status: STARTED
[22:07:47.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:93:0) after 9m21s
[22:17:08.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:93:0)
[22:17:08.713] Build status: STARTED
[22:17:08.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:94:0) after 3m27s
[22:20:36.180] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:94:0)
[22:20:36.213] Build status: STARTED
[22:20:36.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:95:0) after 6m53s
[22:27:29.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:95:0)
[22:27:29.261] Build status: STARTED
[22:27:29.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:96:0) after 3m54s
[22:31:23.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:96:0)
[22:31:23.426] Build status: STARTED
[22:31:23.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:97:0) after 7m2s
[22:38:25.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:97:0)
[22:38:25.649] Build status: STARTED
[22:38:25.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:98:0) after 6m36s
[22:45:01.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:98:0)
[22:45:01.689] Build status: STARTED
[22:45:01.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:99:0) after 5m22s
[22:50:23.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:99:0)
[22:50:23.808] Build status: STARTED
[22:50:23.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:100:0) after 9m23s
[22:59:47.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:100:0)
[22:59:47.217] Build status: STARTED
[22:59:47.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:101:0) after 6m15s
[23:06:02.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:101:0)
[23:06:02.346] Build status: STARTED
[23:06:02.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:102:0) after 2m23s
[23:08:25.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:102:0)
[23:08:25.390] Build status: STARTED
[23:08:25.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:103:0) after 3m25s
[23:11:50.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:103:0)
[23:11:50.533] Build status: STARTED
[23:11:50.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:104:0) after 8m46s
[23:20:36.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:104:0)
[23:20:36.801] Build status: STARTED
[23:20:36.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:105:0) after 7m2s
[23:27:38.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:105:0)
[23:27:38.935] Build status: STARTED
[23:27:38.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8989850884589976528:106:0) after 9m6s
[23:30:54.841] Received PubSub notification, asking Buildbucket for the build status
[23:30:54.882] Build:
{
"id": "8824420822675490417",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 23790,
"createdBy": "project:chromium",
"createTime": "2022-01-21T13:58:46.461156386Z",
"startTime": "2022-01-21T14:01:17.458093Z",
"endTime": "2022-01-21T23:30:53.917114264Z",
"updateTime": "2022-01-21T23:30:53.917114264Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2fd73fb315913114dffefa6c0923c037b3c83c0b",
"ref": "refs/heads/main"
}
}
}
[23:30:54.882] Invocation finished in 9h32m9.630763998s with status FAILED