[14:57:52.162] New invocation is queued and will start shortly
[14:57:53.237] Starting the invocation (attempt 1)
[14:57:53.277] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53a61f9d88b3335cdee488a72f5ca011232ce1ad"
[14:57:53.277] Popped gitiles commit info from properties and tags
[14:57:53.277] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:57:53.277] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:57:53.277] Buildbucket request:
{
"requestId": "8991387313839127424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "53a61f9d88b3335cdee488a72f5ca011232ce1ad",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8991387313839127424"
},
{
"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"
}
}
[14:57:53.744] Scheduled build:
{
"id": "8825957251933380017",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 23734,
"createdBy": "project:chromium",
"createTime": "2022-01-04T14:57:53.339663626Z",
"updateTime": "2022-01-04T14:57:53.339663626Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "53a61f9d88b3335cdee488a72f5ca011232ce1ad",
"ref": "refs/heads/main"
}
}
}
[14:57:53.744] Task URL: https://cr-buildbucket.appspot.com/build/8825957251933380017
[14:57:53.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:2:0) after 1m28s
[14:59:21.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:2:0)
[14:59:21.917] Build status: SCHEDULED
[14:59:21.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:3:0) after 9m20s
[15:00:16.502] Received PubSub notification, asking Buildbucket for the build status
[15:00:17.371] Build status: STARTED
[15:08:41.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:3:0)
[15:08:41.960] Build status: STARTED
[15:08:41.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:5:0) after 5m10s
[15:13:52.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:5:0)
[15:13:52.099] Build status: STARTED
[15:13:52.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:6:0) after 1m21s
[15:15:13.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:6:0)
[15:15:13.355] Build status: STARTED
[15:15:13.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:7:0) after 3m20s
[15:18:33.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:7:0)
[15:18:33.407] Build status: STARTED
[15:18:33.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:8:0) after 9m5s
[15:27:38.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:8:0)
[15:27:38.631] Build status: STARTED
[15:27:38.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:9:0) after 7m4s
[15:34:43.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:9:0)
[15:34:43.116] Build status: STARTED
[15:34:43.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:10:0) after 4m27s
[15:39:10.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:10:0)
[15:39:10.157] Build status: STARTED
[15:39:10.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:11:0) after 4m19s
[15:43:29.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:11:0)
[15:43:29.268] Build status: STARTED
[15:43:29.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:12:0) after 9m14s
[15:52:43.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:12:0)
[15:52:43.292] Build status: STARTED
[15:52:43.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:13:0) after 1m6s
[15:53:49.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:13:0)
[15:53:49.513] Build status: STARTED
[15:53:49.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:14:0) after 5m54s
[15:59:43.536] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:14:0)
[15:59:43.553] Build status: STARTED
[15:59:43.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:15:0) after 6m35s
[16:06:18.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:15:0)
[16:06:18.591] Build status: STARTED
[16:06:18.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:16:0) after 4m5s
[16:10:23.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:16:0)
[16:10:23.787] Build status: STARTED
[16:10:23.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:17:0) after 9m17s
[16:19:40.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:17:0)
[16:19:40.798] Build status: STARTED
[16:19:40.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:18:0) after 3m46s
[16:23:26.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:18:0)
[16:23:26.898] Build status: STARTED
[16:23:26.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:19:0) after 3m48s
[16:27:15.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:19:0)
[16:27:15.271] Build status: STARTED
[16:27:15.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:20:0) after 4m0s
[16:31:15.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:20:0)
[16:31:15.599] Build status: STARTED
[16:31:15.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:21:0) after 3m39s
[16:34:54.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:21:0)
[16:34:54.733] Build status: STARTED
[16:34:54.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:22:0) after 6m32s
[16:41:27.155] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:22:0)
[16:41:27.278] Build status: STARTED
[16:41:27.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:23:0) after 7m16s
[16:48:43.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:23:0)
[16:48:43.584] Build status: STARTED
[16:48:43.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:24:0) after 7m5s
[16:55:48.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:24:0)
[16:55:48.825] Build status: STARTED
[16:55:48.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:25:0) after 9m23s
[17:05:11.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:25:0)
[17:05:11.843] Build status: STARTED
[17:05:11.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:26:0) after 1m54s
[17:07:05.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:26:0)
[17:07:05.885] Build status: STARTED
[17:07:05.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:27:0) after 8m37s
[17:15:43.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:27:0)
[17:15:43.112] Build status: STARTED
[17:15:43.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:28:0) after 2m36s
[17:18:19.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:28:0)
[17:18:19.263] Build status: STARTED
[17:18:19.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:29:0) after 9m33s
[17:27:52.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:29:0)
[17:27:52.640] Build status: STARTED
[17:27:52.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:30:0) after 5m7s
[17:32:59.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:30:0)
[17:32:59.702] Build status: STARTED
[17:32:59.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:31:0) after 6m43s
[17:39:42.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:31:0)
[17:39:42.854] Build status: STARTED
[17:39:42.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:32:0) after 6m50s
[17:46:32.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:32:0)
[17:46:32.924] Build status: STARTED
[17:46:32.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:33:0) after 6m16s
[17:52:49.299] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:33:0)
[17:52:49.329] Build status: STARTED
[17:52:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:34:0) after 6m35s
[17:59:24.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:34:0)
[17:59:24.474] Build status: STARTED
[17:59:24.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:35:0) after 1m45s
[18:01:09.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:35:0)
[18:01:09.846] Build status: STARTED
[18:01:09.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:36:0) after 8m14s
[18:09:23.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:36:0)
[18:09:24.056] Build status: STARTED
[18:09:24.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:37:0) after 3m31s
[18:12:55.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:37:0)
[18:12:55.243] Build status: STARTED
[18:12:55.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:38:0) after 3m37s
[18:16:32.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:38:0)
[18:16:32.593] Build status: STARTED
[18:16:32.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:39:0) after 2m13s
[18:18:45.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:39:0)
[18:18:45.776] Build status: STARTED
[18:18:45.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:40:0) after 3m15s
[18:22:01.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:40:0)
[18:22:01.060] Build status: STARTED
[18:22:01.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:41:0) after 2m41s
[18:24:42.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:41:0)
[18:24:42.158] Build status: STARTED
[18:24:42.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:42:0) after 3m43s
[18:28:25.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:42:0)
[18:28:25.199] Build status: STARTED
[18:28:25.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:43:0) after 2m26s
[18:30:51.220] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:43:0)
[18:30:51.242] Build status: STARTED
[18:30:51.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:44:0) after 6m11s
[18:37:02.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:44:0)
[18:37:02.294] Build status: STARTED
[18:37:02.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:45:0) after 8m19s
[18:45:21.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:45:0)
[18:45:21.551] Build status: STARTED
[18:45:21.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:46:0) after 3m32s
[18:48:53.785] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:46:0)
[18:48:53.816] Build status: STARTED
[18:48:53.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:47:0) after 3m54s
[18:52:47.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:47:0)
[18:52:47.858] Build status: STARTED
[18:52:47.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:48:0) after 9m58s
[19:02:45.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:48:0)
[19:02:46.195] Build status: STARTED
[19:02:46.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:49:0) after 2m50s
[19:05:36.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:49:0)
[19:05:36.873] Build status: STARTED
[19:05:36.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:50:0) after 5m27s
[19:11:03.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:50:0)
[19:11:03.932] Build status: STARTED
[19:11:03.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:51:0) after 2m32s
[19:13:36.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:51:0)
[19:13:36.051] Build status: STARTED
[19:13:36.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:52:0) after 9m42s
[19:23:18.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:52:0)
[19:23:22.111] Build status: STARTED
[19:23:22.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:53:0) after 2m10s
[19:25:32.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:53:0)
[19:25:32.238] Build status: STARTED
[19:25:32.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:54:0) after 4m17s
[19:29:49.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:54:0)
[19:29:49.388] Build status: STARTED
[19:29:49.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:55:0) after 6m28s
[19:36:17.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:55:0)
[19:36:17.535] Build status: STARTED
[19:36:17.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:56:0) after 1m14s
[19:37:31.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:56:0)
[19:37:31.581] Build status: STARTED
[19:37:31.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:57:0) after 1m46s
[19:39:17.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:57:0)
[19:39:17.886] Build status: STARTED
[19:39:17.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:58:0) after 8m39s
[19:47:57.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:58:0)
[19:47:57.065] Build status: STARTED
[19:47:57.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:59:0) after 7m28s
[19:55:25.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:59:0)
[19:55:25.268] Build status: STARTED
[19:55:25.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:60:0) after 5m15s
[20:00:40.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:60:0)
[20:00:40.703] Build status: STARTED
[20:00:40.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:61:0) after 9m8s
[20:09:48.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:61:0)
[20:09:48.718] Build status: STARTED
[20:09:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:62:0) after 3m10s
[20:12:58.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:62:0)
[20:12:58.973] Build status: STARTED
[20:12:58.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:63:0) after 3m25s
[20:16:24.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:63:0)
[20:16:24.138] Build status: STARTED
[20:16:24.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:64:0) after 1m47s
[20:18:11.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:64:0)
[20:18:11.331] Build status: STARTED
[20:18:11.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:65:0) after 3m7s
[20:21:18.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:65:0)
[20:21:18.399] Build status: STARTED
[20:21:18.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:66:0) after 5m50s
[20:27:08.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:66:0)
[20:27:08.519] Build status: STARTED
[20:27:08.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:67:0) after 3m55s
[20:31:03.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:67:0)
[20:31:03.579] Build status: STARTED
[20:31:03.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:68:0) after 4m53s
[20:35:57.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:68:0)
[20:35:57.149] Build status: STARTED
[20:35:57.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:69:0) after 6m18s
[20:42:15.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:69:0)
[20:42:15.213] Build status: STARTED
[20:42:15.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:70:0) after 1m38s
[20:43:53.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:70:0)
[20:43:53.263] Build status: STARTED
[20:43:53.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:71:0) after 2m19s
[20:46:12.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:71:0)
[20:46:12.324] Build status: STARTED
[20:46:12.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:72:0) after 2m20s
[20:48:32.309] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:72:0)
[20:48:32.336] Build status: STARTED
[20:48:32.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:73:0) after 4m1s
[20:52:33.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:73:0)
[20:52:33.770] Build status: STARTED
[20:52:33.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:74:0) after 5m11s
[20:57:44.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:74:0)
[20:57:44.947] Build status: STARTED
[20:57:44.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:75:0) after 9m19s
[21:07:03.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:75:0)
[21:07:04.009] Build status: STARTED
[21:07:04.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:76:0) after 5m8s
[21:12:12.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:76:0)
[21:12:12.135] Build status: STARTED
[21:12:12.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:77:0) after 2m32s
[21:14:44.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:77:0)
[21:14:44.209] Build status: STARTED
[21:14:44.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:78:0) after 7m23s
[21:22:07.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:78:0)
[21:22:07.367] Build status: STARTED
[21:22:07.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:79:0) after 3m50s
[21:25:57.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:79:0)
[21:25:57.470] Build status: STARTED
[21:25:57.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:80:0) after 3m0s
[21:28:57.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:80:0)
[21:28:57.563] Build status: STARTED
[21:28:57.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:81:0) after 6m40s
[21:35:38.204] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:81:0)
[21:35:38.220] Build status: STARTED
[21:35:38.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:82:0) after 4m23s
[21:40:01.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:82:0)
[21:40:01.515] Build status: STARTED
[21:40:01.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:83:0) after 9m5s
[21:49:06.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:83:0)
[21:49:06.665] Build status: STARTED
[21:49:06.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:84:0) after 7m39s
[21:56:45.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:84:0)
[21:56:45.951] Build status: STARTED
[21:56:45.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:85:0) after 5m52s
[22:02:37.974] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:85:0)
[22:02:37.995] Build status: STARTED
[22:02:37.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:86:0) after 7m28s
[22:10:06.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:86:0)
[22:10:06.080] Build status: STARTED
[22:10:06.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:87:0) after 5m34s
[22:15:40.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:87:0)
[22:15:40.148] Build status: STARTED
[22:15:40.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:88:0) after 6m10s
[22:21:50.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:88:0)
[22:21:50.764] Build status: STARTED
[22:21:50.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:89:0) after 4m31s
[22:26:22.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:89:0)
[22:26:22.393] Build status: STARTED
[22:26:22.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:90:0) after 5m36s
[22:31:58.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:90:0)
[22:31:58.779] Build status: STARTED
[22:31:58.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:91:0) after 4m37s
[22:36:35.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:91:0)
[22:36:35.834] Build status: STARTED
[22:36:35.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:92:0) after 6m26s
[22:43:02.140] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:92:0)
[22:43:02.185] Build status: STARTED
[22:43:02.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:93:0) after 9m40s
[22:52:42.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:93:0)
[22:52:42.233] Build status: STARTED
[22:52:42.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:94:0) after 1m37s
[22:54:19.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:94:0)
[22:54:19.328] Build status: STARTED
[22:54:19.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:95:0) after 8m53s
[23:03:12.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:95:0)
[23:03:12.468] Build status: STARTED
[23:03:12.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:96:0) after 1m54s
[23:05:06.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:96:0)
[23:05:06.520] Build status: STARTED
[23:05:06.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:97:0) after 9m14s
[23:14:20.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:97:0)
[23:14:20.645] Build status: STARTED
[23:14:20.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:98:0) after 8m25s
[23:22:45.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:98:0)
[23:22:45.854] Build status: STARTED
[23:22:45.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:99:0) after 5m22s
[23:28:07.875] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:99:0)
[23:28:07.893] Build status: STARTED
[23:28:07.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:100:0) after 7m25s
[23:35:33.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:100:0)
[23:35:33.291] Build status: STARTED
[23:35:33.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:101:0) after 6m47s
[23:42:20.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:101:0)
[23:42:26.711] Build status: STARTED
[23:42:26.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:102:0) after 9m8s
[23:51:35.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:102:0)
[23:51:35.271] Build status: STARTED
[23:51:35.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:103:0) after 5m50s
[23:57:25.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:103:0)
[23:57:25.319] Build status: STARTED
[23:57:25.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:104:0) after 3m37s
[00:01:02.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:104:0)
[00:01:02.436] Build status: STARTED
[00:01:02.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:105:0) after 3m30s
[00:04:32.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:105:0)
[00:04:32.641] Build status: STARTED
[00:04:32.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:106:0) after 5m22s
[00:09:54.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:106:0)
[00:09:54.983] Build status: STARTED
[00:09:54.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:107:0) after 6m33s
[00:16:28.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:107:0)
[00:16:28.289] Build status: STARTED
[00:16:28.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:108:0) after 5m57s
[00:22:25.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:108:0)
[00:22:25.978] Build status: STARTED
[00:22:25.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8991387313839127424:109:0) after 6m27s
[00:25:12.344] Received PubSub notification, asking Buildbucket for the build status
[00:25:12.362] Build:
{
"id": "8825957251933380017",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 23734,
"createdBy": "project:chromium",
"createTime": "2022-01-04T14:57:53.339663626Z",
"startTime": "2022-01-04T15:00:13.687893Z",
"endTime": "2022-01-05T00:25:11.678455309Z",
"updateTime": "2022-01-05T00:25:11.678455309Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "53a61f9d88b3335cdee488a72f5ca011232ce1ad",
"ref": "refs/heads/main"
}
}
}
[00:25:12.362] Invocation finished in 9h27m20.223812673s with status FAILED