[04:40:22.357] New invocation is queued and will start shortly
[04:40:23.919] Starting the invocation (attempt 1)
[04:40:23.952] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:40:23.953] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:40:23.953] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9107390280360723712",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f632099231f55fd0c6bae05d2f7da1c7e66416a2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9107390280360723712",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"gitiles_ref:refs/heads/master"
]
}
[04:40:26.442] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530679224033050",
"experimental": true,
"id": "8941960217938789616",
"lease_expiration_ts": "1530715226134480",
"lease_key": "574390087",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f632099231f55fd0c6bae05d2f7da1c7e66416a2\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1530679226353520",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/1782",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107390280360723712",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Deterministic Android (dbg)/1782",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941960217938789616",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8941960217938789616/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9107390280360723712",
"swarming_tag:scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:761be570b9ddc8b12cd9bf031b7ba136a1879f33",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e7c68f3caf32910",
"user_agent:luci-scheduler"
],
"updated_ts": "1530679226353600",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1782",
"utcnow_ts": "1530679226424650"
}
}
[04:40:26.442] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1782
[04:40:26.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:2:0) after 1m0s
[04:41:09.048] Received PubSub notification, asking Buildbucket for the build status
[04:41:09.186] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:26.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:2:0)
[04:41:26.460] Timer tick, asking Buildbucket for the build status
[04:41:26.535] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:26.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:4:0) after 1m0s
[04:42:26.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:4:0)
[04:42:26.555] Timer tick, asking Buildbucket for the build status
[04:42:26.614] Build 8941960217938789616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:26.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:5:0) after 1m0s
[04:43:04.384] Received PubSub notification, asking Buildbucket for the build status
[04:43:10.698] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:26.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:5:0)
[04:43:26.633] Timer tick, asking Buildbucket for the build status
[04:43:26.775] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:26.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:7:0) after 1m0s
[04:44:26.797] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:7:0)
[04:44:26.797] Timer tick, asking Buildbucket for the build status
[04:44:26.835] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:26.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:8:0) after 1m0s
[04:45:26.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:8:0)
[04:45:26.888] Timer tick, asking Buildbucket for the build status
[04:45:26.952] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:26.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:9:0) after 1m0s
[04:46:27.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:9:0)
[04:46:27.070] Timer tick, asking Buildbucket for the build status
[04:46:27.140] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:27.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:10:0) after 1m0s
[04:47:27.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:10:0)
[04:47:27.256] Timer tick, asking Buildbucket for the build status
[04:47:27.314] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:27.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:11:0) after 1m0s
[04:48:27.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:11:0)
[04:48:27.389] Timer tick, asking Buildbucket for the build status
[04:48:27.430] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:27.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:12:0) after 1m0s
[04:49:27.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:12:0)
[04:49:27.561] Timer tick, asking Buildbucket for the build status
[04:49:27.612] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:27.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:13:0) after 1m0s
[04:50:27.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:13:0)
[04:50:27.633] Timer tick, asking Buildbucket for the build status
[04:50:27.843] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:27.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:14:0) after 1m0s
[04:51:27.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:14:0)
[04:51:27.862] Timer tick, asking Buildbucket for the build status
[04:51:28.018] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:28.018] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:15:0) after 1m0s
[04:52:28.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:15:0)
[04:52:28.040] Timer tick, asking Buildbucket for the build status
[04:52:28.247] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:28.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:16:0) after 1m0s
[04:53:28.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:16:0)
[04:53:28.264] Timer tick, asking Buildbucket for the build status
[04:53:28.331] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:28.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:17:0) after 1m0s
[04:54:28.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:17:0)
[04:54:28.348] Timer tick, asking Buildbucket for the build status
[04:54:28.430] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:28.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:18:0) after 1m0s
[04:55:28.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:18:0)
[04:55:28.451] Timer tick, asking Buildbucket for the build status
[04:55:28.518] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:28.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:19:0) after 1m0s
[04:56:28.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:19:0)
[04:56:28.537] Timer tick, asking Buildbucket for the build status
[04:56:28.579] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:28.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:20:0) after 1m0s
[04:57:28.655] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:20:0)
[04:57:28.655] Timer tick, asking Buildbucket for the build status
[04:57:28.756] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:28.756] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:21:0) after 1m0s
[04:58:28.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:21:0)
[04:58:28.775] Timer tick, asking Buildbucket for the build status
[04:58:29.230] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:29.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:22:0) after 1m0s
[04:59:29.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:22:0)
[04:59:29.251] Timer tick, asking Buildbucket for the build status
[04:59:29.323] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:29.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:23:0) after 1m0s
[05:00:29.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:23:0)
[05:00:29.342] Timer tick, asking Buildbucket for the build status
[05:00:29.453] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:29.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:24:0) after 1m0s
[05:01:29.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:24:0)
[05:01:29.489] Timer tick, asking Buildbucket for the build status
[05:01:29.644] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:29.644] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:25:0) after 1m0s
[05:02:29.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:25:0)
[05:02:29.663] Timer tick, asking Buildbucket for the build status
[05:02:29.738] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:29.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:26:0) after 1m0s
[05:03:29.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:26:0)
[05:03:29.757] Timer tick, asking Buildbucket for the build status
[05:03:29.808] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:29.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:27:0) after 1m0s
[05:04:29.828] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:27:0)
[05:04:29.828] Timer tick, asking Buildbucket for the build status
[05:04:30.036] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:30.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:28:0) after 1m0s
[05:05:30.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:28:0)
[05:05:30.054] Timer tick, asking Buildbucket for the build status
[05:05:30.108] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:30.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:29:0) after 1m0s
[05:06:30.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:29:0)
[05:06:30.147] Timer tick, asking Buildbucket for the build status
[05:06:30.277] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:30.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:30:0) after 1m0s
[05:07:30.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:30:0)
[05:07:30.304] Timer tick, asking Buildbucket for the build status
[05:07:30.414] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:30.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:31:0) after 1m0s
[05:08:30.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:31:0)
[05:08:30.435] Timer tick, asking Buildbucket for the build status
[05:08:30.530] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:30.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:32:0) after 1m0s
[05:09:30.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:32:0)
[05:09:30.558] Timer tick, asking Buildbucket for the build status
[05:09:30.694] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:30.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:33:0) after 1m0s
[05:10:30.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:33:0)
[05:10:30.713] Timer tick, asking Buildbucket for the build status
[05:10:30.765] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:30.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:34:0) after 1m0s
[05:11:30.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:34:0)
[05:11:30.792] Timer tick, asking Buildbucket for the build status
[05:11:30.935] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:30.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:35:0) after 1m0s
[05:12:30.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:35:0)
[05:12:30.966] Timer tick, asking Buildbucket for the build status
[05:12:31.042] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:31.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:36:0) after 1m0s
[05:13:31.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:36:0)
[05:13:31.092] Timer tick, asking Buildbucket for the build status
[05:13:31.224] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:31.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:37:0) after 1m0s
[05:14:31.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:37:0)
[05:14:31.274] Timer tick, asking Buildbucket for the build status
[05:14:31.329] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:31.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:38:0) after 1m0s
[05:15:31.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:38:0)
[05:15:31.350] Timer tick, asking Buildbucket for the build status
[05:15:31.485] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:31.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:39:0) after 1m0s
[05:16:31.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:39:0)
[05:16:31.526] Timer tick, asking Buildbucket for the build status
[05:16:31.653] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:31.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:40:0) after 1m0s
[05:17:31.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:40:0)
[05:17:31.671] Timer tick, asking Buildbucket for the build status
[05:17:31.841] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:31.841] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:41:0) after 1m0s
[05:18:31.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:41:0)
[05:18:31.861] Timer tick, asking Buildbucket for the build status
[05:18:31.895] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:31.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:42:0) after 1m0s
[05:19:31.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:42:0)
[05:19:31.914] Timer tick, asking Buildbucket for the build status
[05:19:32.073] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:32.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:43:0) after 1m0s
[05:20:32.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:43:0)
[05:20:32.092] Timer tick, asking Buildbucket for the build status
[05:20:32.127] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:32.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:44:0) after 1m0s
[05:21:32.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:44:0)
[05:21:32.203] Timer tick, asking Buildbucket for the build status
[05:21:32.255] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:32.255] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:45:0) after 1m0s
[05:22:32.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:45:0)
[05:22:32.303] Timer tick, asking Buildbucket for the build status
[05:22:32.395] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:32.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:46:0) after 1m0s
[05:23:32.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:46:0)
[05:23:32.501] Timer tick, asking Buildbucket for the build status
[05:23:32.692] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:32.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:47:0) after 1m0s
[05:24:32.889] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:47:0)
[05:24:32.889] Timer tick, asking Buildbucket for the build status
[05:24:32.923] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:32.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:48:0) after 1m0s
[05:25:32.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:48:0)
[05:25:32.944] Timer tick, asking Buildbucket for the build status
[05:25:33.001] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:33.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:49:0) after 1m0s
[05:26:33.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:49:0)
[05:26:33.023] Timer tick, asking Buildbucket for the build status
[05:26:33.119] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:33.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:50:0) after 1m0s
[05:27:33.141] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:50:0)
[05:27:33.141] Timer tick, asking Buildbucket for the build status
[05:27:33.614] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:33.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:51:0) after 1m0s
[05:28:33.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:51:0)
[05:28:33.634] Timer tick, asking Buildbucket for the build status
[05:28:33.767] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:33.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:52:0) after 1m0s
[05:29:33.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:52:0)
[05:29:33.787] Timer tick, asking Buildbucket for the build status
[05:29:33.864] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:33.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:53:0) after 1m0s
[05:30:33.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:53:0)
[05:30:33.884] Timer tick, asking Buildbucket for the build status
[05:30:34.035] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:34.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:54:0) after 1m0s
[05:31:34.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:54:0)
[05:31:34.054] Timer tick, asking Buildbucket for the build status
[05:31:34.158] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:34.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:55:0) after 1m0s
[05:32:34.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:55:0)
[05:32:34.188] Timer tick, asking Buildbucket for the build status
[05:32:34.347] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:34.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:56:0) after 1m0s
[05:33:34.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:56:0)
[05:33:34.504] Timer tick, asking Buildbucket for the build status
[05:33:34.649] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:34.649] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:57:0) after 1m0s
[05:34:34.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:57:0)
[05:34:34.671] Timer tick, asking Buildbucket for the build status
[05:34:34.946] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:34.946] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:58:0) after 1m0s
[05:35:34.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:58:0)
[05:35:34.966] Timer tick, asking Buildbucket for the build status
[05:35:35.029] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:35.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:59:0) after 1m0s
[05:36:35.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:59:0)
[05:36:35.051] Timer tick, asking Buildbucket for the build status
[05:36:35.101] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:35.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:60:0) after 1m0s
[05:37:35.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:60:0)
[05:37:35.139] Timer tick, asking Buildbucket for the build status
[05:37:35.224] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:35.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:61:0) after 1m0s
[05:38:35.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:61:0)
[05:38:35.354] Timer tick, asking Buildbucket for the build status
[05:38:35.426] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:35.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:62:0) after 1m0s
[05:39:35.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:62:0)
[05:39:35.564] Timer tick, asking Buildbucket for the build status
[05:39:35.716] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:35.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:63:0) after 1m0s
[05:40:35.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:63:0)
[05:40:35.738] Timer tick, asking Buildbucket for the build status
[05:40:35.776] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:35.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:64:0) after 1m0s
[05:41:35.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:64:0)
[05:41:35.799] Timer tick, asking Buildbucket for the build status
[05:41:35.918] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:35.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:65:0) after 1m0s
[05:42:35.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:65:0)
[05:42:35.939] Timer tick, asking Buildbucket for the build status
[05:42:36.065] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:36.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:66:0) after 1m0s
[05:43:36.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:66:0)
[05:43:36.198] Timer tick, asking Buildbucket for the build status
[05:43:36.340] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:36.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:67:0) after 1m0s
[05:44:36.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:67:0)
[05:44:36.489] Timer tick, asking Buildbucket for the build status
[05:44:36.664] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:36.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:68:0) after 1m0s
[05:45:36.694] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:68:0)
[05:45:36.694] Timer tick, asking Buildbucket for the build status
[05:45:36.749] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:36.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:69:0) after 1m0s
[05:46:36.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:69:0)
[05:46:36.774] Timer tick, asking Buildbucket for the build status
[05:46:36.937] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:36.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:70:0) after 1m0s
[05:47:36.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:70:0)
[05:47:36.993] Timer tick, asking Buildbucket for the build status
[05:47:37.047] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:37.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:71:0) after 1m0s
[05:48:37.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:71:0)
[05:48:37.084] Timer tick, asking Buildbucket for the build status
[05:48:37.187] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:37.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:72:0) after 1m0s
[05:49:37.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:72:0)
[05:49:37.294] Timer tick, asking Buildbucket for the build status
[05:49:37.329] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:37.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:73:0) after 1m0s
[05:50:37.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:73:0)
[05:50:37.432] Timer tick, asking Buildbucket for the build status
[05:50:37.487] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:37.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:74:0) after 1m0s
[05:51:37.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:74:0)
[05:51:37.510] Timer tick, asking Buildbucket for the build status
[05:51:37.700] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:37.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:75:0) after 1m0s
[05:52:37.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:75:0)
[05:52:37.725] Timer tick, asking Buildbucket for the build status
[05:52:37.856] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:37.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:76:0) after 1m0s
[05:53:37.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:76:0)
[05:53:37.993] Timer tick, asking Buildbucket for the build status
[05:53:38.034] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:38.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:77:0) after 1m0s
[05:54:38.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:77:0)
[05:54:38.055] Timer tick, asking Buildbucket for the build status
[05:54:38.087] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:38.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:78:0) after 1m0s
[05:55:38.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:78:0)
[05:55:38.107] Timer tick, asking Buildbucket for the build status
[05:55:38.228] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:38.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:79:0) after 1m0s
[05:56:38.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:79:0)
[05:56:38.298] Timer tick, asking Buildbucket for the build status
[05:56:38.343] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:38.343] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:80:0) after 1m0s
[05:57:38.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:80:0)
[05:57:38.408] Timer tick, asking Buildbucket for the build status
[05:57:38.599] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:38.599] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:81:0) after 1m0s
[05:58:38.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:81:0)
[05:58:38.621] Timer tick, asking Buildbucket for the build status
[05:58:38.706] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:38.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:82:0) after 1m0s
[05:59:38.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:82:0)
[05:59:38.985] Timer tick, asking Buildbucket for the build status
[05:59:39.016] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:39.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:83:0) after 1m0s
[06:00:39.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:83:0)
[06:00:39.044] Timer tick, asking Buildbucket for the build status
[06:00:39.101] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:39.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:84:0) after 1m0s
[06:01:39.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:84:0)
[06:01:39.171] Timer tick, asking Buildbucket for the build status
[06:01:39.242] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:39.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:85:0) after 1m0s
[06:02:39.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:85:0)
[06:02:39.373] Timer tick, asking Buildbucket for the build status
[06:02:39.744] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:39.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:86:0) after 1m0s
[06:03:39.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:86:0)
[06:03:39.767] Timer tick, asking Buildbucket for the build status
[06:03:39.921] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:39.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:87:0) after 1m0s
[06:04:39.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:87:0)
[06:04:39.945] Timer tick, asking Buildbucket for the build status
[06:04:40.211] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:40.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:88:0) after 1m0s
[06:05:40.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:88:0)
[06:05:40.235] Timer tick, asking Buildbucket for the build status
[06:05:40.329] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:40.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:89:0) after 1m0s
[06:06:40.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:89:0)
[06:06:40.355] Timer tick, asking Buildbucket for the build status
[06:06:40.438] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:40.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:90:0) after 1m0s
[06:07:40.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:90:0)
[06:07:40.463] Timer tick, asking Buildbucket for the build status
[06:07:40.676] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:40.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:91:0) after 1m0s
[06:08:40.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:91:0)
[06:08:40.697] Timer tick, asking Buildbucket for the build status
[06:08:40.829] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:40.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:92:0) after 1m0s
[06:09:40.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:92:0)
[06:09:40.853] Timer tick, asking Buildbucket for the build status
[06:09:40.959] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:40.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:93:0) after 1m0s
[06:10:40.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:93:0)
[06:10:40.983] Timer tick, asking Buildbucket for the build status
[06:10:41.016] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:41.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:94:0) after 1m0s
[06:11:41.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:94:0)
[06:11:41.178] Timer tick, asking Buildbucket for the build status
[06:11:41.486] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:41.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:95:0) after 1m0s
[06:12:41.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:95:0)
[06:12:41.563] Timer tick, asking Buildbucket for the build status
[06:12:41.680] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:41.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:96:0) after 1m0s
[06:13:41.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:96:0)
[06:13:41.700] Timer tick, asking Buildbucket for the build status
[06:13:41.755] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:41.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:97:0) after 1m0s
[06:14:41.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:97:0)
[06:14:41.835] Timer tick, asking Buildbucket for the build status
[06:14:41.914] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:41.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:98:0) after 1m0s
[06:15:42.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:98:0)
[06:15:42.037] Timer tick, asking Buildbucket for the build status
[06:15:42.137] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:42.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:99:0) after 1m0s
[06:16:42.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:99:0)
[06:16:42.267] Timer tick, asking Buildbucket for the build status
[06:16:42.299] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:42.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:100:0) after 1m0s
[06:17:42.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:100:0)
[06:17:42.435] Timer tick, asking Buildbucket for the build status
[06:17:42.629] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:42.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:101:0) after 1m0s
[06:18:42.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:101:0)
[06:18:42.660] Timer tick, asking Buildbucket for the build status
[06:18:42.752] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:42.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:102:0) after 1m0s
[06:19:42.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:102:0)
[06:19:42.774] Timer tick, asking Buildbucket for the build status
[06:19:42.838] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:42.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:103:0) after 1m0s
[06:20:42.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:103:0)
[06:20:42.861] Timer tick, asking Buildbucket for the build status
[06:20:42.982] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:42.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:104:0) after 1m0s
[06:21:43.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:104:0)
[06:21:43.006] Timer tick, asking Buildbucket for the build status
[06:21:43.038] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:43.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:105:0) after 1m0s
[06:22:43.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:105:0)
[06:22:43.064] Timer tick, asking Buildbucket for the build status
[06:22:43.118] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:43.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:106:0) after 1m0s
[06:23:43.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:106:0)
[06:23:43.235] Timer tick, asking Buildbucket for the build status
[06:23:43.429] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:43.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:107:0) after 1m0s
[06:24:43.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:107:0)
[06:24:43.448] Timer tick, asking Buildbucket for the build status
[06:24:43.495] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:43.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:108:0) after 1m0s
[06:25:43.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:108:0)
[06:25:43.516] Timer tick, asking Buildbucket for the build status
[06:25:43.547] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:43.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:109:0) after 1m0s
[06:26:43.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:109:0)
[06:26:43.570] Timer tick, asking Buildbucket for the build status
[06:26:43.744] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:43.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:110:0) after 1m0s
[06:27:43.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:110:0)
[06:27:43.767] Timer tick, asking Buildbucket for the build status
[06:27:43.838] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:43.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:111:0) after 1m0s
[06:28:43.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:111:0)
[06:28:43.860] Timer tick, asking Buildbucket for the build status
[06:28:44.003] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:44.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:112:0) after 1m0s
[06:29:44.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:112:0)
[06:29:44.027] Timer tick, asking Buildbucket for the build status
[06:29:44.067] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:44.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:113:0) after 1m0s
[06:30:44.187] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:113:0)
[06:30:44.187] Timer tick, asking Buildbucket for the build status
[06:30:44.299] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:44.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:114:0) after 1m0s
[06:31:44.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:114:0)
[06:31:44.322] Timer tick, asking Buildbucket for the build status
[06:31:44.373] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:44.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:115:0) after 1m0s
[06:32:44.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:115:0)
[06:32:44.420] Timer tick, asking Buildbucket for the build status
[06:32:44.537] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:44.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:116:0) after 1m0s
[06:33:44.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:116:0)
[06:33:44.667] Timer tick, asking Buildbucket for the build status
[06:33:44.907] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:44.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:117:0) after 1m0s
[06:34:44.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:117:0)
[06:34:44.929] Timer tick, asking Buildbucket for the build status
[06:34:45.065] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:45.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:118:0) after 1m0s
[06:35:45.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:118:0)
[06:35:45.087] Timer tick, asking Buildbucket for the build status
[06:35:45.157] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:45.157] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:119:0) after 1m0s
[06:36:45.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:119:0)
[06:36:45.192] Timer tick, asking Buildbucket for the build status
[06:36:45.372] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:45.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:120:0) after 1m0s
[06:37:45.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:120:0)
[06:37:45.399] Timer tick, asking Buildbucket for the build status
[06:37:45.801] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:45.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:121:0) after 1m0s
[06:38:45.947] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:121:0)
[06:38:45.947] Timer tick, asking Buildbucket for the build status
[06:38:46.048] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:46.048] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:122:0) after 1m0s
[06:39:46.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:122:0)
[06:39:46.071] Timer tick, asking Buildbucket for the build status
[06:39:46.156] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:46.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:123:0) after 1m0s
[06:40:46.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:123:0)
[06:40:46.177] Timer tick, asking Buildbucket for the build status
[06:40:46.215] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:46.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:124:0) after 1m0s
[06:41:46.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:124:0)
[06:41:46.264] Timer tick, asking Buildbucket for the build status
[06:41:46.472] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:46.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:125:0) after 1m0s
[06:42:46.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:125:0)
[06:42:46.586] Timer tick, asking Buildbucket for the build status
[06:42:46.622] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:46.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:126:0) after 1m0s
[06:43:46.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:126:0)
[06:43:46.660] Timer tick, asking Buildbucket for the build status
[06:43:47.170] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:47.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:127:0) after 1m0s
[06:44:47.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:127:0)
[06:44:47.192] Timer tick, asking Buildbucket for the build status
[06:44:47.233] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:47.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:128:0) after 1m0s
[06:45:47.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:128:0)
[06:45:47.256] Timer tick, asking Buildbucket for the build status
[06:45:47.435] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:47.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:129:0) after 1m0s
[06:46:47.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:129:0)
[06:46:47.578] Timer tick, asking Buildbucket for the build status
[06:46:47.639] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:47.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:130:0) after 1m0s
[06:47:47.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:130:0)
[06:47:47.661] Timer tick, asking Buildbucket for the build status
[06:47:47.714] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:47.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:131:0) after 1m0s
[06:48:47.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:131:0)
[06:48:47.735] Timer tick, asking Buildbucket for the build status
[06:48:47.802] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:47.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:132:0) after 1m0s
[06:49:47.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:132:0)
[06:49:47.824] Timer tick, asking Buildbucket for the build status
[06:49:47.884] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:47.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:133:0) after 1m0s
[06:50:47.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:133:0)
[06:50:47.908] Timer tick, asking Buildbucket for the build status
[06:50:48.286] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:48.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:134:0) after 1m0s
[06:51:48.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:134:0)
[06:51:48.312] Timer tick, asking Buildbucket for the build status
[06:51:48.367] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:48.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:135:0) after 1m0s
[06:52:48.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:135:0)
[06:52:48.399] Timer tick, asking Buildbucket for the build status
[06:52:48.433] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:48.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:136:0) after 1m0s
[06:53:48.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:136:0)
[06:53:48.464] Timer tick, asking Buildbucket for the build status
[06:53:48.541] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:48.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:137:0) after 1m0s
[06:54:48.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:137:0)
[06:54:48.564] Timer tick, asking Buildbucket for the build status
[06:54:48.662] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:48.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:138:0) after 1m0s
[06:55:48.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:138:0)
[06:55:48.724] Timer tick, asking Buildbucket for the build status
[06:55:48.774] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:48.774] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:139:0) after 1m0s
[06:56:48.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:139:0)
[06:56:48.808] Timer tick, asking Buildbucket for the build status
[06:56:48.882] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:48.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:140:0) after 1m0s
[06:57:48.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:140:0)
[06:57:48.918] Timer tick, asking Buildbucket for the build status
[06:57:49.001] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:49.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:141:0) after 1m0s
[06:58:49.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:141:0)
[06:58:49.028] Timer tick, asking Buildbucket for the build status
[06:58:49.060] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:49.060] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:142:0) after 1m0s
[06:59:49.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:142:0)
[06:59:49.083] Timer tick, asking Buildbucket for the build status
[06:59:49.318] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:49.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:143:0) after 1m0s
[07:00:49.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:143:0)
[07:00:49.343] Timer tick, asking Buildbucket for the build status
[07:00:49.456] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:49.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:144:0) after 1m0s
[07:01:49.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:144:0)
[07:01:49.479] Timer tick, asking Buildbucket for the build status
[07:01:49.531] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:49.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:145:0) after 1m0s
[07:02:49.560] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:145:0)
[07:02:49.560] Timer tick, asking Buildbucket for the build status
[07:02:49.740] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:49.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:146:0) after 1m0s
[07:03:49.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:146:0)
[07:03:49.810] Timer tick, asking Buildbucket for the build status
[07:03:49.928] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:49.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:147:0) after 1m0s
[07:04:49.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:147:0)
[07:04:49.951] Timer tick, asking Buildbucket for the build status
[07:04:50.096] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:50.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:148:0) after 1m0s
[07:05:50.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:148:0)
[07:05:50.123] Timer tick, asking Buildbucket for the build status
[07:05:50.200] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:50.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:149:0) after 1m0s
[07:06:50.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:149:0)
[07:06:50.239] Timer tick, asking Buildbucket for the build status
[07:06:50.288] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:50.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:150:0) after 1m0s
[07:07:50.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:150:0)
[07:07:50.317] Timer tick, asking Buildbucket for the build status
[07:07:50.381] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:50.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:151:0) after 1m0s
[07:08:50.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:151:0)
[07:08:50.407] Timer tick, asking Buildbucket for the build status
[07:08:50.493] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:50.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:152:0) after 1m0s
[07:09:50.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:152:0)
[07:09:50.517] Timer tick, asking Buildbucket for the build status
[07:09:50.628] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:50.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:153:0) after 1m0s
[07:10:50.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:153:0)
[07:10:50.653] Timer tick, asking Buildbucket for the build status
[07:10:50.713] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:50.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:154:0) after 1m0s
[07:11:50.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:154:0)
[07:11:50.738] Timer tick, asking Buildbucket for the build status
[07:11:50.811] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:50.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:155:0) after 1m0s
[07:12:50.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:155:0)
[07:12:50.898] Timer tick, asking Buildbucket for the build status
[07:12:51.011] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:51.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:156:0) after 1m0s
[07:13:51.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:156:0)
[07:13:51.113] Timer tick, asking Buildbucket for the build status
[07:13:51.179] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:51.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:157:0) after 1m0s
[07:14:51.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:157:0)
[07:14:51.300] Timer tick, asking Buildbucket for the build status
[07:14:51.354] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:51.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:158:0) after 1m0s
[07:15:51.447] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:158:0)
[07:15:51.447] Timer tick, asking Buildbucket for the build status
[07:15:51.643] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:51.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:159:0) after 1m0s
[07:16:51.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:159:0)
[07:16:51.680] Timer tick, asking Buildbucket for the build status
[07:16:51.740] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:160:0) after 1m0s
[07:17:51.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:160:0)
[07:17:51.777] Timer tick, asking Buildbucket for the build status
[07:17:51.875] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:161:0) after 1m0s
[07:18:51.900] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:161:0)
[07:18:51.900] Timer tick, asking Buildbucket for the build status
[07:18:52.163] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:52.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:162:0) after 1m0s
[07:19:52.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:162:0)
[07:19:52.198] Timer tick, asking Buildbucket for the build status
[07:19:52.244] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:52.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:163:0) after 1m0s
[07:20:52.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:163:0)
[07:20:52.353] Timer tick, asking Buildbucket for the build status
[07:20:53.911] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:53.911] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:164:0) after 1m0s
[07:21:53.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:164:0)
[07:21:53.970] Timer tick, asking Buildbucket for the build status
[07:21:54.025] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:54.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:165:0) after 1m0s
[07:22:54.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:165:0)
[07:22:54.267] Timer tick, asking Buildbucket for the build status
[07:22:54.339] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:54.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:166:0) after 1m0s
[07:23:54.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:166:0)
[07:23:54.473] Timer tick, asking Buildbucket for the build status
[07:23:54.517] Build 8941960217938789616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:54.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107390280360723712:167:0) after 1m0s
[07:24:47.270] Received PubSub notification, asking Buildbucket for the build status
[07:24:47.308] Build 8941960217938789616: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[07:24:47.308] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1530689086086290",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530679224033050",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8941960217938789616",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f632099231f55fd0c6bae05d2f7da1c7e66416a2\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\\nFailure Uncaught Exception\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"recipe infra failure: Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\", \"bootstrapperCallStack\": [], \"type\": \"RECIPE_INFRA_FAILURE\"}, \"recipeResult\": {\"failure\": {\"exception\": {\"traceback\": [\"Traceback (most recent call last):\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/run.py\\\", line 287, in _new_run\", \" recipe_result = recipe_script.run(api, self.properties, self.environ)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 108, in run\", \" self.run_steps, properties, environ, self.PROPERTIES, api=api)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 636, in invoke_with_properties\", \" arg_names, **additional_args)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 599, in _invoke_with_properties\", \" return callable_obj(*props, **additional_args)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipes/swarming/deterministic_build.py\\\", line 194, in RunSteps\", \" str(api.chromium.output_dir).rstrip('\\\\\\\\/') + '.2')\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/recipe_api.py\\\", line 759, in _inner\", \" return func(*a, **kw)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/isolate/api.py\\\", line 350, in compare_build_artifacts\", \" self.archive_differences(first_dir, second_dir, step_result.json.output)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/recipe_api.py\\\", line 759, in _inner\", \" return func(*a, **kw)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/isolate/api.py\\\", line 302, in archive_differences\", \" diffs = list(itertools.chain.from_iterable(values.itervalues()))\", \"AttributeError: 'NoneType' object has no attribute 'itervalues'\"]}, \"humanReason\": \"Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8941960217938789616/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Android (dbg)\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3675-21ffa58\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm629-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"030b88a205c9ce9a82d68798bfaa059fd55216cd\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"f632099231f55fd0c6bae05d2f7da1c7e66416a2\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23827}\", \"$build/goma\": {\"jobs\": 150}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_src_revision_cp\": \"refs/heads/master@{#572476}\", \"got_src_revision\": \"f632099231f55fd0c6bae05d2f7da1c7e66416a2\", \"got_revision_cp\": \"refs/heads/master@{#572476}\", \"branch\": \"refs/heads/master\", \"revision\": \"f632099231f55fd0c6bae05d2f7da1c7e66416a2\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Android (dbg)\", \"got_webrtc_revision\": \"57900cb93360989624d0b165baab2f08ebebb92e\", \"mastername\": \"chromium.android\", \"got_angle_revision\": \"2b06054dd41f3c26d656f4ed7043a90e1f934f07\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1530679224033050, \"tags\": [\"builder:Deterministic Android (dbg)\", \"buildset:commit/git/f632099231f55fd0c6bae05d2f7da1c7e66416a2\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f632099231f55fd0c6bae05d2f7da1c7e66416a2\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9107390280360723712\", \"scheduler_job_id:chromium/Deterministic Android (dbg)\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8941960217938789616\"}}, \"got_v8_revision\": \"fe51067f43e7208d06977d5036726360a4539d7b\", \"got_v8_revision_cp\": \"refs/heads/6.9.285@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 1782, \"path_config\": \"generic\", \"bot_id\": \"swarm629-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1530679267759860",
"status": "COMPLETED",
"status_changed_ts": "1530689086800950",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/1782",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107390280360723712",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Deterministic Android (dbg)/1782",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941960217938789616",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f632099231f55fd0c6bae05d2f7da1c7e66416a2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8941960217938789616/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9107390280360723712",
"swarming_tag:scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:761be570b9ddc8b12cd9bf031b7ba136a1879f33",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e7c68f3caf32910",
"user_agent:luci-scheduler"
],
"updated_ts": "1530689086803100",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1782",
"utcnow_ts": "1530689087296480"
}
}
[07:24:47.308] Invocation finished in 2h44m24.967875343s with status FAILED