[05:50:44.687] New invocation is queued and will start shortly
[05:50:45.906] Starting the invocation (attempt 1)
[05:50:46.002] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:50:46.002] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:50:46.002] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077307660082588096",
"parameters_json": "{\"builder_name\":\"Deterministic Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"05d6128cf8227ee5fbeb362f8ddf73a7a0970024\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android",
"scheduler_invocation_id:9077307660082588096",
"scheduler_job_id:chromium/Deterministic Android",
"user_agent:luci-scheduler",
"buildset:commit/git/05d6128cf8227ee5fbeb362f8ddf73a7a0970024",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05d6128cf8227ee5fbeb362f8ddf73a7a0970024",
"gitiles_ref:refs/heads/master"
]
}
[05:50:47.217] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559368246144255",
"experimental": true,
"id": "8911877597889540240",
"parameters_json": "{\"builder_name\": \"Deterministic Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"05d6128cf8227ee5fbeb362f8ddf73a7a0970024\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559368247004251",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android/5319",
"builder:Deterministic Android",
"buildset:commit/git/05d6128cf8227ee5fbeb362f8ddf73a7a0970024",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05d6128cf8227ee5fbeb362f8ddf73a7a0970024",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077307660082588096",
"scheduler_job_id:chromium/Deterministic Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911877597889540240/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1559368247005577",
"url": "https://ci.chromium.org/b/8911877597889540240",
"utcnow_ts": "1559368247205475"
}
}
[05:50:47.217] Task URL: https://ci.chromium.org/b/8911877597889540240
[05:50:47.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:2:0) after 1m0s
[05:51:24.720] Received PubSub notification, asking Buildbucket for the build status
[05:51:26.441] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:47.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:2:0)
[05:51:47.290] Timer tick, asking Buildbucket for the build status
[05:51:47.431] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:47.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:4:0) after 1m0s
[05:52:47.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:4:0)
[05:52:47.650] Timer tick, asking Buildbucket for the build status
[05:52:49.518] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:49.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:5:0) after 1m0s
[05:53:49.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:5:0)
[05:53:49.747] Timer tick, asking Buildbucket for the build status
[05:53:50.324] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:50.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:6:0) after 1m0s
[05:54:50.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:6:0)
[05:54:50.429] Timer tick, asking Buildbucket for the build status
[05:54:50.828] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:50.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:7:0) after 1m0s
[05:55:50.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:7:0)
[05:55:50.924] Timer tick, asking Buildbucket for the build status
[05:55:51.268] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:51.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:8:0) after 1m0s
[05:56:51.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:8:0)
[05:56:51.303] Timer tick, asking Buildbucket for the build status
[05:56:52.232] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:52.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:9:0) after 1m0s
[05:57:52.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:9:0)
[05:57:52.251] Timer tick, asking Buildbucket for the build status
[05:57:52.487] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:52.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:10:0) after 1m0s
[05:58:52.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:10:0)
[05:58:52.582] Timer tick, asking Buildbucket for the build status
[05:58:53.102] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:53.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:11:0) after 1m0s
[05:59:53.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:11:0)
[05:59:53.282] Timer tick, asking Buildbucket for the build status
[05:59:53.513] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:53.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:12:0) after 1m0s
[06:00:53.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:12:0)
[06:00:53.541] Timer tick, asking Buildbucket for the build status
[06:00:54.044] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:54.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:13:0) after 1m0s
[06:01:54.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:13:0)
[06:01:54.194] Timer tick, asking Buildbucket for the build status
[06:01:54.391] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:54.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:14:0) after 1m0s
[06:02:54.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:14:0)
[06:02:54.432] Timer tick, asking Buildbucket for the build status
[06:02:54.801] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:54.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:15:0) after 1m0s
[06:03:54.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:15:0)
[06:03:54.868] Timer tick, asking Buildbucket for the build status
[06:03:55.632] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:55.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:16:0) after 1m0s
[06:04:55.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:16:0)
[06:04:55.903] Timer tick, asking Buildbucket for the build status
[06:04:56.564] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:56.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:17:0) after 1m0s
[06:05:56.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:17:0)
[06:05:56.771] Timer tick, asking Buildbucket for the build status
[06:05:58.567] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:58.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:18:0) after 1m0s
[06:06:58.593] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:18:0)
[06:06:58.593] Timer tick, asking Buildbucket for the build status
[06:06:59.776] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:59.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:19:0) after 1m0s
[06:07:59.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:19:0)
[06:07:59.876] Timer tick, asking Buildbucket for the build status
[06:08:01.437] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:01.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:20:0) after 1m0s
[06:09:01.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:20:0)
[06:09:01.456] Timer tick, asking Buildbucket for the build status
[06:09:02.455] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:02.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:21:0) after 1m0s
[06:10:02.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:21:0)
[06:10:02.473] Timer tick, asking Buildbucket for the build status
[06:10:04.226] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:04.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:22:0) after 1m0s
[06:11:04.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:22:0)
[06:11:04.246] Timer tick, asking Buildbucket for the build status
[06:11:04.855] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:04.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:23:0) after 1m0s
[06:12:04.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:23:0)
[06:12:04.914] Timer tick, asking Buildbucket for the build status
[06:12:06.260] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:24:0) after 1m0s
[06:13:06.279] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:24:0)
[06:13:06.279] Timer tick, asking Buildbucket for the build status
[06:13:06.383] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:06.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:25:0) after 1m0s
[06:14:07.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:25:0)
[06:14:07.174] Timer tick, asking Buildbucket for the build status
[06:14:07.568] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:07.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:26:0) after 1m0s
[06:15:07.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:26:0)
[06:15:07.638] Timer tick, asking Buildbucket for the build status
[06:15:08.136] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:08.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:27:0) after 1m0s
[06:16:08.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:27:0)
[06:16:08.205] Timer tick, asking Buildbucket for the build status
[06:16:08.863] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:08.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:28:0) after 1m0s
[06:17:08.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:28:0)
[06:17:08.953] Timer tick, asking Buildbucket for the build status
[06:17:09.054] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:09.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:29:0) after 1m0s
[06:18:09.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:29:0)
[06:18:09.076] Timer tick, asking Buildbucket for the build status
[06:18:10.643] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:10.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:30:0) after 1m0s
[06:19:10.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:30:0)
[06:19:10.707] Timer tick, asking Buildbucket for the build status
[06:19:10.808] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:10.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:31:0) after 1m0s
[06:20:10.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:31:0)
[06:20:10.859] Timer tick, asking Buildbucket for the build status
[06:20:12.425] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:12.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:32:0) after 1m0s
[06:21:12.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:32:0)
[06:21:12.442] Timer tick, asking Buildbucket for the build status
[06:21:13.616] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:13.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:33:0) after 1m0s
[06:22:13.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:33:0)
[06:22:13.694] Timer tick, asking Buildbucket for the build status
[06:22:14.003] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:14.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:34:0) after 1m0s
[06:23:14.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:34:0)
[06:23:14.029] Timer tick, asking Buildbucket for the build status
[06:23:14.246] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:14.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:35:0) after 1m0s
[06:24:14.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:35:0)
[06:24:14.281] Timer tick, asking Buildbucket for the build status
[06:24:14.721] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:14.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:36:0) after 1m0s
[06:25:14.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:36:0)
[06:25:14.962] Timer tick, asking Buildbucket for the build status
[06:25:17.682] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:17.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:37:0) after 1m0s
[06:26:17.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:37:0)
[06:26:17.703] Timer tick, asking Buildbucket for the build status
[06:26:17.913] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:17.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:38:0) after 1m0s
[06:27:17.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:38:0)
[06:27:17.937] Timer tick, asking Buildbucket for the build status
[06:27:18.026] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:18.026] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:39:0) after 1m0s
[06:28:18.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:39:0)
[06:28:18.082] Timer tick, asking Buildbucket for the build status
[06:28:18.773] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:18.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:40:0) after 1m0s
[06:29:18.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:40:0)
[06:29:18.799] Timer tick, asking Buildbucket for the build status
[06:29:18.963] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:18.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:41:0) after 1m0s
[06:30:18.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:41:0)
[06:30:18.982] Timer tick, asking Buildbucket for the build status
[06:30:19.262] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:19.262] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:42:0) after 1m0s
[06:31:19.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:42:0)
[06:31:19.297] Timer tick, asking Buildbucket for the build status
[06:31:19.704] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:19.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:43:0) after 1m0s
[06:32:19.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:43:0)
[06:32:19.728] Timer tick, asking Buildbucket for the build status
[06:32:19.937] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:19.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:44:0) after 1m0s
[06:33:19.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:44:0)
[06:33:19.964] Timer tick, asking Buildbucket for the build status
[06:33:20.058] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:20.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:45:0) after 1m0s
[06:34:20.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:45:0)
[06:34:20.101] Timer tick, asking Buildbucket for the build status
[06:34:21.108] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:21.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:46:0) after 1m0s
[06:35:21.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:46:0)
[06:35:21.135] Timer tick, asking Buildbucket for the build status
[06:35:21.273] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:47:0) after 1m0s
[06:36:21.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:47:0)
[06:36:21.330] Timer tick, asking Buildbucket for the build status
[06:36:21.461] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:21.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:48:0) after 1m0s
[06:37:21.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:48:0)
[06:37:21.470] Timer tick, asking Buildbucket for the build status
[06:37:21.594] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:21.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:49:0) after 1m0s
[06:38:21.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:49:0)
[06:38:21.666] Timer tick, asking Buildbucket for the build status
[06:38:22.019] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:22.019] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:50:0) after 1m0s
[06:39:22.042] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:50:0)
[06:39:22.042] Timer tick, asking Buildbucket for the build status
[06:39:22.434] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:22.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:51:0) after 1m0s
[06:40:22.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:51:0)
[06:40:22.460] Timer tick, asking Buildbucket for the build status
[06:40:22.564] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:22.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:52:0) after 1m0s
[06:41:22.637] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:52:0)
[06:41:22.637] Timer tick, asking Buildbucket for the build status
[06:41:22.814] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:22.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:53:0) after 1m0s
[06:42:22.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:53:0)
[06:42:22.838] Timer tick, asking Buildbucket for the build status
[06:42:23.086] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:23.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:54:0) after 1m0s
[06:43:23.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:54:0)
[06:43:23.114] Timer tick, asking Buildbucket for the build status
[06:43:23.226] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:23.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:55:0) after 1m0s
[06:44:23.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:55:0)
[06:44:23.250] Timer tick, asking Buildbucket for the build status
[06:44:23.355] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:23.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:56:0) after 1m0s
[06:45:23.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:56:0)
[06:45:23.414] Timer tick, asking Buildbucket for the build status
[06:45:23.496] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:23.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:57:0) after 1m0s
[06:46:23.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:57:0)
[06:46:23.622] Timer tick, asking Buildbucket for the build status
[06:46:24.186] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:24.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:58:0) after 1m0s
[06:47:24.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:58:0)
[06:47:24.195] Timer tick, asking Buildbucket for the build status
[06:47:25.940] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:25.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:59:0) after 1m0s
[06:48:25.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:59:0)
[06:48:25.994] Timer tick, asking Buildbucket for the build status
[06:48:26.490] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:26.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:60:0) after 1m0s
[06:49:26.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:60:0)
[06:49:26.511] Timer tick, asking Buildbucket for the build status
[06:49:26.671] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:26.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:61:0) after 1m0s
[06:50:26.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:61:0)
[06:50:26.739] Timer tick, asking Buildbucket for the build status
[06:50:27.031] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:27.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:62:0) after 1m0s
[06:51:27.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:62:0)
[06:51:27.097] Timer tick, asking Buildbucket for the build status
[06:51:28.785] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:28.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:63:0) after 1m0s
[06:52:28.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:63:0)
[06:52:28.890] Timer tick, asking Buildbucket for the build status
[06:52:28.990] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:28.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:64:0) after 1m0s
[06:53:29.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:64:0)
[06:53:29.023] Timer tick, asking Buildbucket for the build status
[06:53:29.378] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:29.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:65:0) after 1m0s
[06:54:29.478] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:65:0)
[06:54:29.478] Timer tick, asking Buildbucket for the build status
[06:54:30.365] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:30.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:66:0) after 1m0s
[06:55:30.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:66:0)
[06:55:30.439] Timer tick, asking Buildbucket for the build status
[06:55:30.612] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:30.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:67:0) after 1m0s
[06:56:30.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:67:0)
[06:56:30.636] Timer tick, asking Buildbucket for the build status
[06:56:30.742] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:30.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:68:0) after 1m0s
[06:57:30.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:68:0)
[06:57:30.803] Timer tick, asking Buildbucket for the build status
[06:57:30.992] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:30.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:69:0) after 1m0s
[06:58:31.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:69:0)
[06:58:31.013] Timer tick, asking Buildbucket for the build status
[06:58:31.272] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:31.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:70:0) after 1m0s
[06:59:31.315] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:70:0)
[06:59:31.315] Timer tick, asking Buildbucket for the build status
[06:59:32.392] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:32.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:71:0) after 1m0s
[07:00:32.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:71:0)
[07:00:32.432] Timer tick, asking Buildbucket for the build status
[07:00:35.335] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:35.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:72:0) after 1m0s
[07:01:35.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:72:0)
[07:01:35.359] Timer tick, asking Buildbucket for the build status
[07:01:35.448] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:35.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:73:0) after 1m0s
[07:02:35.485] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:73:0)
[07:02:35.485] Timer tick, asking Buildbucket for the build status
[07:02:37.551] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:37.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:74:0) after 1m0s
[07:03:37.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:74:0)
[07:03:37.570] Timer tick, asking Buildbucket for the build status
[07:03:38.717] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:38.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:75:0) after 1m0s
[07:04:38.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:75:0)
[07:04:38.808] Timer tick, asking Buildbucket for the build status
[07:04:40.380] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:40.380] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:76:0) after 1m0s
[07:05:40.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:76:0)
[07:05:40.404] Timer tick, asking Buildbucket for the build status
[07:05:40.724] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:40.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:77:0) after 1m0s
[07:06:40.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:77:0)
[07:06:40.744] Timer tick, asking Buildbucket for the build status
[07:06:42.236] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:42.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:78:0) after 1m0s
[07:07:42.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:78:0)
[07:07:42.263] Timer tick, asking Buildbucket for the build status
[07:07:43.585] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:43.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:79:0) after 1m0s
[07:08:43.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:79:0)
[07:08:43.659] Timer tick, asking Buildbucket for the build status
[07:08:44.014] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:44.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:80:0) after 1m0s
[07:09:44.060] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:80:0)
[07:09:44.060] Timer tick, asking Buildbucket for the build status
[07:09:45.034] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:45.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:81:0) after 1m0s
[07:10:45.061] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:81:0)
[07:10:45.061] Timer tick, asking Buildbucket for the build status
[07:10:45.884] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:45.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:82:0) after 1m0s
[07:11:46.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:82:0)
[07:11:46.043] Timer tick, asking Buildbucket for the build status
[07:11:47.067] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:47.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:83:0) after 1m0s
[07:12:47.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:83:0)
[07:12:47.049] Timer tick, asking Buildbucket for the build status
[07:12:47.317] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:47.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:84:0) after 1m0s
[07:13:47.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:84:0)
[07:13:47.338] Timer tick, asking Buildbucket for the build status
[07:13:48.212] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:48.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:85:0) after 1m0s
[07:14:48.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:85:0)
[07:14:48.234] Timer tick, asking Buildbucket for the build status
[07:14:49.258] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:49.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:86:0) after 1m0s
[07:15:49.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:86:0)
[07:15:49.404] Timer tick, asking Buildbucket for the build status
[07:15:50.153] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:50.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:87:0) after 1m0s
[07:16:50.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:87:0)
[07:16:50.176] Timer tick, asking Buildbucket for the build status
[07:16:50.385] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:88:0) after 1m0s
[07:17:50.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:88:0)
[07:17:50.446] Timer tick, asking Buildbucket for the build status
[07:17:50.586] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:50.586] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:89:0) after 1m0s
[07:18:50.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:89:0)
[07:18:50.693] Timer tick, asking Buildbucket for the build status
[07:18:50.953] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:90:0) after 1m0s
[07:19:51.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:90:0)
[07:19:51.371] Timer tick, asking Buildbucket for the build status
[07:19:51.474] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:51.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:91:0) after 1m0s
[07:20:52.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:91:0)
[07:20:52.082] Timer tick, asking Buildbucket for the build status
[07:20:52.482] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:52.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:92:0) after 1m0s
[07:21:52.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:92:0)
[07:21:52.532] Timer tick, asking Buildbucket for the build status
[07:21:52.787] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:52.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:93:0) after 1m0s
[07:22:52.851] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:93:0)
[07:22:52.851] Timer tick, asking Buildbucket for the build status
[07:22:54.212] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:54.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:94:0) after 1m0s
[07:23:54.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:94:0)
[07:23:54.234] Timer tick, asking Buildbucket for the build status
[07:23:54.392] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:54.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:95:0) after 1m0s
[07:24:54.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:95:0)
[07:24:54.449] Timer tick, asking Buildbucket for the build status
[07:24:55.382] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:55.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:96:0) after 1m0s
[07:25:55.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:96:0)
[07:25:55.403] Timer tick, asking Buildbucket for the build status
[07:25:55.697] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:55.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:97:0) after 1m0s
[07:26:55.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:97:0)
[07:26:55.739] Timer tick, asking Buildbucket for the build status
[07:26:56.668] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:56.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:98:0) after 1m0s
[07:27:56.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:98:0)
[07:27:56.741] Timer tick, asking Buildbucket for the build status
[07:27:56.895] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:56.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:99:0) after 1m0s
[07:28:56.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:99:0)
[07:28:56.920] Timer tick, asking Buildbucket for the build status
[07:28:59.108] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:59.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:100:0) after 1m0s
[07:29:59.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:100:0)
[07:29:59.131] Timer tick, asking Buildbucket for the build status
[07:29:59.295] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:59.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:101:0) after 1m0s
[07:30:59.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:101:0)
[07:30:59.351] Timer tick, asking Buildbucket for the build status
[07:30:59.748] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:59.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:102:0) after 1m0s
[07:31:59.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:102:0)
[07:31:59.829] Timer tick, asking Buildbucket for the build status
[07:32:00.149] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:00.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:103:0) after 1m0s
[07:33:00.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:103:0)
[07:33:00.262] Timer tick, asking Buildbucket for the build status
[07:33:00.669] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:00.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:104:0) after 1m0s
[07:34:00.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:104:0)
[07:34:00.692] Timer tick, asking Buildbucket for the build status
[07:34:01.552] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:01.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:105:0) after 1m0s
[07:35:01.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:105:0)
[07:35:01.570] Timer tick, asking Buildbucket for the build status
[07:35:01.739] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:01.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:106:0) after 1m0s
[07:36:01.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:106:0)
[07:36:01.754] Timer tick, asking Buildbucket for the build status
[07:36:02.509] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:02.510] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:107:0) after 1m0s
[07:37:02.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:107:0)
[07:37:02.572] Timer tick, asking Buildbucket for the build status
[07:37:02.726] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:02.726] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:108:0) after 1m0s
[07:38:02.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:108:0)
[07:38:02.754] Timer tick, asking Buildbucket for the build status
[07:38:03.127] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:03.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:109:0) after 1m0s
[07:39:03.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:109:0)
[07:39:03.185] Timer tick, asking Buildbucket for the build status
[07:39:07.011] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:07.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:110:0) after 1m0s
[07:40:07.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:110:0)
[07:40:07.077] Timer tick, asking Buildbucket for the build status
[07:40:08.000] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:08.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:111:0) after 1m0s
[07:41:08.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:111:0)
[07:41:08.109] Timer tick, asking Buildbucket for the build status
[07:41:08.466] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:08.466] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:112:0) after 1m0s
[07:42:08.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:112:0)
[07:42:08.614] Timer tick, asking Buildbucket for the build status
[07:42:11.973] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:11.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:113:0) after 1m0s
[07:43:12.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:113:0)
[07:43:12.063] Timer tick, asking Buildbucket for the build status
[07:43:12.949] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:12.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:114:0) after 1m0s
[07:44:12.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:114:0)
[07:44:12.969] Timer tick, asking Buildbucket for the build status
[07:44:13.461] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:13.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:115:0) after 1m0s
[07:45:13.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:115:0)
[07:45:13.458] Timer tick, asking Buildbucket for the build status
[07:45:13.569] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:13.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:116:0) after 1m0s
[07:46:13.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:116:0)
[07:46:13.621] Timer tick, asking Buildbucket for the build status
[07:46:13.979] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:13.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:117:0) after 1m0s
[07:47:14.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:117:0)
[07:47:14.088] Timer tick, asking Buildbucket for the build status
[07:47:14.243] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:14.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:118:0) after 1m0s
[07:48:14.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:118:0)
[07:48:14.317] Timer tick, asking Buildbucket for the build status
[07:48:14.431] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:14.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:119:0) after 1m0s
[07:49:14.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:119:0)
[07:49:14.526] Timer tick, asking Buildbucket for the build status
[07:49:16.661] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:16.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:120:0) after 1m0s
[07:50:17.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:120:0)
[07:50:17.015] Timer tick, asking Buildbucket for the build status
[07:50:17.381] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:17.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:121:0) after 1m0s
[07:51:17.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:121:0)
[07:51:17.622] Timer tick, asking Buildbucket for the build status
[07:51:17.818] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:17.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:122:0) after 1m0s
[07:52:18.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:122:0)
[07:52:18.093] Timer tick, asking Buildbucket for the build status
[07:52:20.744] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:123:0) after 1m0s
[07:53:20.770] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:123:0)
[07:53:20.770] Timer tick, asking Buildbucket for the build status
[07:53:21.128] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:21.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:124:0) after 1m0s
[07:54:21.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:124:0)
[07:54:21.398] Timer tick, asking Buildbucket for the build status
[07:54:21.620] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:21.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:125:0) after 1m0s
[07:55:21.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:125:0)
[07:55:21.711] Timer tick, asking Buildbucket for the build status
[07:55:22.976] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:22.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:126:0) after 1m0s
[07:56:23.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:126:0)
[07:56:23.143] Timer tick, asking Buildbucket for the build status
[07:56:24.807] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:24.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:127:0) after 1m0s
[07:57:25.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:127:0)
[07:57:25.125] Timer tick, asking Buildbucket for the build status
[07:57:26.232] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:26.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:128:0) after 1m0s
[07:58:26.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:128:0)
[07:58:26.401] Timer tick, asking Buildbucket for the build status
[07:58:26.598] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:26.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:129:0) after 1m0s
[07:59:26.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:129:0)
[07:59:26.728] Timer tick, asking Buildbucket for the build status
[07:59:27.234] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:27.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:130:0) after 1m0s
[08:00:27.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:130:0)
[08:00:27.285] Timer tick, asking Buildbucket for the build status
[08:00:27.548] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:27.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:131:0) after 1m0s
[08:01:27.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:131:0)
[08:01:27.597] Timer tick, asking Buildbucket for the build status
[08:01:27.737] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:27.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:132:0) after 1m0s
[08:02:27.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:132:0)
[08:02:27.759] Timer tick, asking Buildbucket for the build status
[08:02:27.909] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:27.909] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:133:0) after 1m0s
[08:03:27.935] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:133:0)
[08:03:27.935] Timer tick, asking Buildbucket for the build status
[08:03:29.292] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:29.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:134:0) after 1m0s
[08:04:29.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:134:0)
[08:04:29.584] Timer tick, asking Buildbucket for the build status
[08:04:30.053] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:30.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:135:0) after 1m0s
[08:05:30.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:135:0)
[08:05:30.108] Timer tick, asking Buildbucket for the build status
[08:05:31.500] Build 8911877597889540240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9077307660082588096:136:0) after 1m0s
[08:05:56.730] Received PubSub notification, asking Buildbucket for the build status
[08:05:57.876] Build 8911877597889540240: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:05:57.876] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559376356282760",
"created_by": "project:chromium",
"created_ts": "1559368246144255",
"experimental": true,
"failure_reason": "BUILD_FAILURE",
"id": "8911877597889540240",
"parameters_json": "{\"builder_name\": \"Deterministic Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"05d6128cf8227ee5fbeb362f8ddf73a7a0970024\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"properties\": {\"$build/goma\": {\"jobs\": 150.0}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"bot_id\": \"deterministic-android-rel-0-y0is\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Android\", \"buildnumber\": 5319, \"got_angle_revision\": \"f7106d16306ae3a98a37100ee028b5aaeca63586\", \"got_dawn_revision\": \"839053b90c7718b9162a123ce040117d2d223cc3\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"05d6128cf8227ee5fbeb362f8ddf73a7a0970024\", \"got_revision_cp\": \"refs/heads/master@{#665397}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"2cb25737c9eb7893ac752674e75d400b4419f67c\", \"got_v8_revision_cp\": \"refs/heads/7.6.303@{#1}\", \"got_webrtc_revision\": \"2229cf79157c199f840998277d9e483770f7c93e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28125}\", \"mastername\": \"chromium.android\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"05d6128cf8227ee5fbeb362f8ddf73a7a0970024\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Deterministic Android\"], \"caches\": [\"builder_0442f466ee54a95cfb510061921bb277cbb8d5a6f79e09e045baf9198c2b257e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"deterministic-android-rel-0-y0is\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559368281591174",
"status": "COMPLETED",
"status_changed_ts": "1559368282755770",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android/5319",
"builder:Deterministic Android",
"buildset:commit/git/05d6128cf8227ee5fbeb362f8ddf73a7a0970024",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05d6128cf8227ee5fbeb362f8ddf73a7a0970024",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077307660082588096",
"scheduler_job_id:chromium/Deterministic Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911877597889540240/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:452a68b07cfacc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1559376356399071",
"url": "https://ci.chromium.org/b/8911877597889540240",
"utcnow_ts": "1559376357836303"
}
}
[08:05:57.876] Invocation finished in 2h15m13.206971798s with status FAILED