[01:11:23.529] New invocation is queued and will start shortly
[01:11:24.813] Starting the invocation (attempt 1)
[01:11:24.845] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:11:24.848] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:11:24.848] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017621834575111680",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b8844f580d7798bcc595c2909c1b1512c65177a8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9017621834575111680",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b8844f580d7798bcc595c2909c1b1512c65177a8",
"gitiles_ref:refs/heads/master"
]
}
[01:11:25.620] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616289084921128",
"id": "8852191772447936768",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b8844f580d7798bcc595c2909c1b1512c65177a8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616289085316654",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/21752",
"builder:ToTiOSDevice",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b8844f580d7798bcc595c2909c1b1512c65177a8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017621834575111680",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852191772447936768/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1616289085316759",
"url": "https://ci.chromium.org/b/8852191772447936768",
"utcnow_ts": "1616289085615061"
}
}
[01:11:25.620] Task URL: https://ci.chromium.org/b/8852191772447936768
[01:11:25.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:2:0) after 1m0s
[01:12:25.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:2:0)
[01:12:25.827] Timer tick, asking Buildbucket for the build status
[01:12:25.907] Build 8852191772447936768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:25.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:3:0) after 1m0s
[01:13:26.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:3:0)
[01:13:26.025] Build status: SCHEDULED
[01:13:26.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:4:0) after 3m25s
[01:14:17.238] Received PubSub notification, asking Buildbucket for the build status
[01:14:17.309] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:51.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:4:0)
[01:16:51.232] Build status: STARTED
[01:16:51.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:6:0) after 1m20s
[01:18:11.348] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:6:0)
[01:18:11.349] Timer tick, asking Buildbucket for the build status
[01:18:11.438] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:11.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:7:0) after 1m0s
[01:19:11.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:7:0)
[01:19:11.495] Build status: STARTED
[01:19:11.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:8:0) after 9m42s
[01:28:53.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:8:0)
[01:28:53.533] Build status: STARTED
[01:28:53.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:9:0) after 1m16s
[01:30:09.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:9:0)
[01:30:09.576] Build status: STARTED
[01:30:09.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:10:0) after 6m41s
[01:36:50.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:10:0)
[01:36:50.603] Timer tick, asking Buildbucket for the build status
[01:36:50.690] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:50.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:11:0) after 1m0s
[01:37:50.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:11:0)
[01:37:50.736] Build status: STARTED
[01:37:50.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:12:0) after 2m41s
[01:40:31.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:12:0)
[01:40:31.781] Build status: STARTED
[01:40:31.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:13:0) after 2m13s
[01:42:44.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:13:0)
[01:42:44.798] Timer tick, asking Buildbucket for the build status
[01:42:44.881] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:44.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:14:0) after 1m0s
[01:43:44.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:14:0)
[01:43:44.909] Timer tick, asking Buildbucket for the build status
[01:43:44.984] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:44.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:15:0) after 1m0s
[01:44:45.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:15:0)
[01:44:45.002] Timer tick, asking Buildbucket for the build status
[01:44:45.067] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:45.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:16:0) after 1m0s
[01:45:45.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:16:0)
[01:45:45.098] Timer tick, asking Buildbucket for the build status
[01:45:45.171] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:45.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:17:0) after 1m0s
[01:46:45.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:17:0)
[01:46:45.194] Timer tick, asking Buildbucket for the build status
[01:46:45.403] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:45.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:18:0) after 1m0s
[01:47:45.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:18:0)
[01:47:45.457] Build status: STARTED
[01:47:45.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:19:0) after 5m17s
[01:53:02.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:19:0)
[01:53:02.665] Build status: STARTED
[01:53:02.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:20:0) after 3m30s
[01:56:32.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:20:0)
[01:56:32.771] Timer tick, asking Buildbucket for the build status
[01:56:32.845] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:21:0) after 1m0s
[01:57:32.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:21:0)
[01:57:32.893] Build status: STARTED
[01:57:32.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:22:0) after 1m47s
[01:59:19.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:22:0)
[01:59:19.965] Timer tick, asking Buildbucket for the build status
[01:59:20.040] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:20.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:23:0) after 1m0s
[02:00:20.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:23:0)
[02:00:20.232] Build status: STARTED
[02:00:20.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:24:0) after 8m51s
[02:09:11.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:24:0)
[02:09:11.364] Build status: STARTED
[02:09:11.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:25:0) after 7m58s
[02:17:09.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:25:0)
[02:17:09.413] Build status: STARTED
[02:17:09.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:26:0) after 5m33s
[02:22:42.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:26:0)
[02:22:42.555] Build status: STARTED
[02:22:42.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:27:0) after 6m56s
[02:29:38.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:27:0)
[02:29:38.595] Build status: STARTED
[02:29:38.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:28:0) after 2m46s
[02:32:24.587] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:28:0)
[02:32:24.587] Timer tick, asking Buildbucket for the build status
[02:32:24.751] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:24.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:29:0) after 1m0s
[02:33:24.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:29:0)
[02:33:24.907] Build status: STARTED
[02:33:24.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:30:0) after 9m45s
[02:43:11.786] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:30:0)
[02:43:11.813] Build status: STARTED
[02:43:11.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:31:0) after 5m35s
[02:48:46.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:31:0)
[02:48:46.902] Build status: STARTED
[02:48:46.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:32:0) after 4m51s
[02:53:37.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:32:0)
[02:53:37.980] Build status: STARTED
[02:53:37.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:33:0) after 4m53s
[02:58:31.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:33:0)
[02:58:31.200] Build status: STARTED
[02:58:31.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:34:0) after 4m51s
[03:03:22.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:34:0)
[03:03:22.217] Timer tick, asking Buildbucket for the build status
[03:03:22.311] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:22.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:35:0) after 1m0s
[03:04:22.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:35:0)
[03:04:22.339] Timer tick, asking Buildbucket for the build status
[03:04:22.401] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:22.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:36:0) after 1m0s
[03:05:22.600] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:36:0)
[03:05:22.625] Build status: STARTED
[03:05:22.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:37:0) after 5m29s
[03:10:51.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:37:0)
[03:10:51.793] Timer tick, asking Buildbucket for the build status
[03:10:51.865] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:51.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:38:0) after 1m0s
[03:11:52.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:38:0)
[03:11:52.082] Build status: STARTED
[03:11:52.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:39:0) after 9m20s
[03:21:12.281] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:39:0)
[03:21:12.281] Timer tick, asking Buildbucket for the build status
[03:21:12.384] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:12.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:40:0) after 1m0s
[03:22:12.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:40:0)
[03:22:12.573] Build status: STARTED
[03:22:12.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:41:0) after 4m20s
[03:26:32.642] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:41:0)
[03:26:32.642] Timer tick, asking Buildbucket for the build status
[03:26:33.235] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:33.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:42:0) after 1m0s
[03:27:33.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:42:0)
[03:27:33.327] Build status: STARTED
[03:27:33.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:43:0) after 1m24s
[03:28:57.349] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:43:0)
[03:28:57.373] Build status: STARTED
[03:28:57.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:44:0) after 2m45s
[03:31:42.392] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:44:0)
[03:31:42.392] Timer tick, asking Buildbucket for the build status
[03:31:42.474] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:42.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:45:0) after 1m0s
[03:32:42.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:45:0)
[03:32:42.498] Timer tick, asking Buildbucket for the build status
[03:32:42.563] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:42.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:46:0) after 1m0s
[03:33:42.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:46:0)
[03:33:42.614] Timer tick, asking Buildbucket for the build status
[03:33:42.684] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:42.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:47:0) after 1m0s
[03:34:42.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:47:0)
[03:34:42.915] Build status: STARTED
[03:34:42.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:48:0) after 3m18s
[03:38:01.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:48:0)
[03:38:01.167] Timer tick, asking Buildbucket for the build status
[03:38:01.270] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:01.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:49:0) after 1m0s
[03:39:01.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:49:0)
[03:39:01.409] Timer tick, asking Buildbucket for the build status
[03:39:01.502] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:01.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:50:0) after 1m0s
[03:40:01.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:50:0)
[03:40:01.699] Timer tick, asking Buildbucket for the build status
[03:40:02.038] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:02.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:51:0) after 1m0s
[03:41:02.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:51:0)
[03:41:02.230] Build status: STARTED
[03:41:02.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:52:0) after 4m26s
[03:45:28.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:52:0)
[03:45:28.268] Build status: STARTED
[03:45:28.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:53:0) after 7m4s
[03:52:32.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:53:0)
[03:52:32.315] Build status: STARTED
[03:52:32.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:54:0) after 2m0s
[03:54:32.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:54:0)
[03:54:32.361] Build status: STARTED
[03:54:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:55:0) after 8m13s
[04:02:45.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:55:0)
[04:02:45.381] Timer tick, asking Buildbucket for the build status
[04:02:45.463] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:45.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:56:0) after 1m0s
[04:03:45.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:56:0)
[04:03:45.507] Build status: STARTED
[04:03:45.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:57:0) after 4m5s
[04:07:50.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:57:0)
[04:07:50.562] Timer tick, asking Buildbucket for the build status
[04:07:50.939] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:50.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:58:0) after 1m0s
[04:08:51.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:58:0)
[04:08:51.090] Build status: STARTED
[04:08:51.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:59:0) after 6m29s
[04:15:20.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:59:0)
[04:15:20.143] Build status: STARTED
[04:15:20.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:60:0) after 1m26s
[04:16:46.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:60:0)
[04:16:46.230] Build status: STARTED
[04:16:46.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:61:0) after 4m21s
[04:21:07.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:61:0)
[04:21:07.340] Build status: STARTED
[04:21:07.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:62:0) after 3m23s
[04:24:30.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:62:0)
[04:24:30.414] Build status: STARTED
[04:24:30.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:63:0) after 9m27s
[04:33:57.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:63:0)
[04:33:57.640] Timer tick, asking Buildbucket for the build status
[04:33:57.757] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:57.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:64:0) after 1m0s
[04:34:57.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:64:0)
[04:34:57.803] Build status: STARTED
[04:34:57.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:65:0) after 1m38s
[04:36:35.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:65:0)
[04:36:35.827] Timer tick, asking Buildbucket for the build status
[04:36:35.890] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:35.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:66:0) after 1m0s
[04:37:35.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:66:0)
[04:37:35.941] Build status: STARTED
[04:37:35.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:67:0) after 7m51s
[04:45:27.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:67:0)
[04:45:27.069] Timer tick, asking Buildbucket for the build status
[04:45:27.303] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:27.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:68:0) after 1m0s
[04:46:27.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:68:0)
[04:46:27.370] Timer tick, asking Buildbucket for the build status
[04:46:27.434] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:27.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:69:0) after 1m0s
[04:47:27.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:69:0)
[04:47:27.486] Timer tick, asking Buildbucket for the build status
[04:47:27.567] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:27.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:70:0) after 1m0s
[04:48:27.688] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:70:0)
[04:48:27.718] Build status: STARTED
[04:48:27.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:71:0) after 7m59s
[04:56:26.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:71:0)
[04:56:26.740] Timer tick, asking Buildbucket for the build status
[04:56:26.928] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:26.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:72:0) after 1m0s
[04:57:26.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:72:0)
[04:57:26.983] Build status: STARTED
[04:57:26.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:73:0) after 8m59s
[05:06:26.003] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:73:0)
[05:06:26.029] Build status: STARTED
[05:06:26.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:74:0) after 8m9s
[05:14:35.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:74:0)
[05:14:35.094] Timer tick, asking Buildbucket for the build status
[05:14:35.176] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:35.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:75:0) after 1m0s
[05:15:35.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:75:0)
[05:15:35.194] Timer tick, asking Buildbucket for the build status
[05:15:35.260] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:35.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:76:0) after 1m0s
[05:16:35.279] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:76:0)
[05:16:35.319] Build status: STARTED
[05:16:35.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:77:0) after 4m31s
[05:21:06.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:77:0)
[05:21:06.371] Build status: STARTED
[05:21:06.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:78:0) after 9m13s
[05:30:19.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:78:0)
[05:30:19.422] Build status: STARTED
[05:30:19.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:79:0) after 8m40s
[05:38:59.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:79:0)
[05:38:59.731] Timer tick, asking Buildbucket for the build status
[05:38:59.806] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:59.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:80:0) after 1m0s
[05:39:59.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:80:0)
[05:39:59.966] Build status: STARTED
[05:39:59.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:81:0) after 6m12s
[05:46:11.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:81:0)
[05:46:11.997] Timer tick, asking Buildbucket for the build status
[05:46:12.094] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:12.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:82:0) after 1m0s
[05:47:12.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:82:0)
[05:47:12.168] Build status: STARTED
[05:47:12.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:83:0) after 4m35s
[05:51:47.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:83:0)
[05:51:47.173] Timer tick, asking Buildbucket for the build status
[05:51:47.254] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:47.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:84:0) after 1m0s
[05:52:47.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:84:0)
[05:52:47.274] Timer tick, asking Buildbucket for the build status
[05:52:47.337] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:47.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:85:0) after 1m0s
[05:53:47.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:85:0)
[05:53:47.353] Timer tick, asking Buildbucket for the build status
[05:53:47.423] Build 8852191772447936768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:47.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9017621834575111680:86:0) after 1m0s
[05:54:40.062] Received PubSub notification, asking Buildbucket for the build status
[05:54:40.088] Build:
{
"id": "8852191772447936768",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 21752,
"createdBy": "project:chromium",
"createTime": "2021-03-21T01:11:24.921128Z",
"startTime": "2021-03-21T01:14:16.405104Z",
"endTime": "2021-03-21T05:54:39.740137365Z",
"updateTime": "2021-03-21T05:54:39.740452287Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b8844f580d7798bcc595c2909c1b1512c65177a8",
"ref": "refs/heads/master"
}
}
}
[05:54:40.089] Invocation finished in 4h43m16.579446022s with status FAILED