[21:57:48.203] New invocation is queued and will start shortly
[21:57:49.431] Starting the invocation (attempt 1)
[21:57:49.464] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:57:49.464] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:57:49.464] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9089205617595702368",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b4a400db5ec1e0a2a3d48c012150f476511cef7b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9089205617595702368",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"gitiles_ref:refs/heads/master"
]
}
[21:57:51.566] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548021469613416",
"experimental": true,
"id": "8923775555437770912",
"lease_expiration_ts": "1548140271221149",
"lease_key": "565764814",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b4a400db5ec1e0a2a3d48c012150f476511cef7b\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1548021471327417",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/3555",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089205617595702368",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"swarming_dimension:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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)/3555",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923775555437770912",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"swarming_tag:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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/8923775555437770912/+/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:9089205617595702368",
"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:5746c1addf0a4c286f58c69ab0c42aedaac6b5ff",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4286169e53833110",
"user_agent:luci-scheduler"
],
"updated_ts": "1548021471327503",
"url": "https://ci.chromium.org/b/8923775555437770912",
"utcnow_ts": "1548021471556784"
}
}
[21:57:51.566] Task URL: https://ci.chromium.org/b/8923775555437770912
[21:57:51.566] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:2:0) after 1m0s
[21:57:52.596] Received PubSub notification, asking Buildbucket for the build status
[21:57:52.658] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:51.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:2:0)
[21:58:51.582] Timer tick, asking Buildbucket for the build status
[21:58:51.660] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:51.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:4:0) after 1m0s
[21:59:51.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:4:0)
[21:59:51.704] Timer tick, asking Buildbucket for the build status
[21:59:51.772] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:51.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:5:0) after 1m0s
[22:00:51.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:5:0)
[22:00:51.800] Timer tick, asking Buildbucket for the build status
[22:00:51.948] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:51.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:6:0) after 1m0s
[22:01:51.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:6:0)
[22:01:51.962] Timer tick, asking Buildbucket for the build status
[22:01:52.046] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:52.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:7:0) after 1m0s
[22:02:52.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:7:0)
[22:02:52.075] Timer tick, asking Buildbucket for the build status
[22:02:52.136] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:52.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:8:0) after 1m0s
[22:03:52.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:8:0)
[22:03:52.152] Timer tick, asking Buildbucket for the build status
[22:03:52.529] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:52.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:9:0) after 1m0s
[22:04:52.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:9:0)
[22:04:52.544] Timer tick, asking Buildbucket for the build status
[22:04:52.652] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:10:0) after 1m0s
[22:05:52.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:10:0)
[22:05:52.665] Timer tick, asking Buildbucket for the build status
[22:05:52.708] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:52.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:11:0) after 1m0s
[22:06:52.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:11:0)
[22:06:52.725] Timer tick, asking Buildbucket for the build status
[22:06:52.787] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:52.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:12:0) after 1m0s
[22:07:52.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:12:0)
[22:07:52.805] Timer tick, asking Buildbucket for the build status
[22:07:52.858] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:13:0) after 1m0s
[22:08:52.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:13:0)
[22:08:52.876] Timer tick, asking Buildbucket for the build status
[22:08:52.999] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:52.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:14:0) after 1m0s
[22:09:53.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:14:0)
[22:09:53.054] Timer tick, asking Buildbucket for the build status
[22:09:53.156] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:53.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:15:0) after 1m0s
[22:10:53.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:15:0)
[22:10:53.172] Timer tick, asking Buildbucket for the build status
[22:10:53.230] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:53.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:16:0) after 1m0s
[22:11:53.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:16:0)
[22:11:53.252] Timer tick, asking Buildbucket for the build status
[22:11:53.310] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:53.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:17:0) after 1m0s
[22:12:53.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:17:0)
[22:12:53.328] Timer tick, asking Buildbucket for the build status
[22:12:53.390] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:53.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:18:0) after 1m0s
[22:13:53.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:18:0)
[22:13:53.405] Timer tick, asking Buildbucket for the build status
[22:13:53.463] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:53.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:19:0) after 1m0s
[22:14:53.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:19:0)
[22:14:53.480] Timer tick, asking Buildbucket for the build status
[22:14:53.563] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:53.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:20:0) after 1m0s
[22:15:53.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:20:0)
[22:15:53.578] Timer tick, asking Buildbucket for the build status
[22:15:53.633] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:53.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:21:0) after 1m0s
[22:16:53.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:21:0)
[22:16:53.648] Timer tick, asking Buildbucket for the build status
[22:16:53.684] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:53.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:22:0) after 1m0s
[22:17:53.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:22:0)
[22:17:53.700] Timer tick, asking Buildbucket for the build status
[22:17:53.754] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:53.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:23:0) after 1m0s
[22:18:53.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:23:0)
[22:18:53.826] Timer tick, asking Buildbucket for the build status
[22:18:53.865] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:53.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:24:0) after 1m0s
[22:19:53.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:24:0)
[22:19:53.956] Timer tick, asking Buildbucket for the build status
[22:19:54.041] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:54.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:25:0) after 1m0s
[22:20:54.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:25:0)
[22:20:54.058] Timer tick, asking Buildbucket for the build status
[22:20:54.329] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:54.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:26:0) after 1m0s
[22:21:54.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:26:0)
[22:21:54.359] Timer tick, asking Buildbucket for the build status
[22:21:54.425] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:54.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:27:0) after 1m0s
[22:22:54.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:27:0)
[22:22:54.443] Timer tick, asking Buildbucket for the build status
[22:22:54.560] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:54.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:28:0) after 1m0s
[22:23:54.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:28:0)
[22:23:54.580] Timer tick, asking Buildbucket for the build status
[22:23:54.660] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:54.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:29:0) after 1m0s
[22:24:54.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:29:0)
[22:24:54.684] Timer tick, asking Buildbucket for the build status
[22:24:54.799] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:54.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:30:0) after 1m0s
[22:25:54.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:30:0)
[22:25:54.816] Timer tick, asking Buildbucket for the build status
[22:25:54.883] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:54.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:31:0) after 1m0s
[22:26:54.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:31:0)
[22:26:54.919] Timer tick, asking Buildbucket for the build status
[22:26:54.955] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:54.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:32:0) after 1m0s
[22:27:54.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:32:0)
[22:27:54.974] Timer tick, asking Buildbucket for the build status
[22:27:55.064] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:55.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:33:0) after 1m0s
[22:28:55.047] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:33:0)
[22:28:55.047] Timer tick, asking Buildbucket for the build status
[22:28:55.125] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:55.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:34:0) after 1m0s
[22:29:55.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:34:0)
[22:29:55.146] Timer tick, asking Buildbucket for the build status
[22:29:55.350] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:55.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:35:0) after 1m0s
[22:30:55.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:35:0)
[22:30:55.460] Timer tick, asking Buildbucket for the build status
[22:30:55.632] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:55.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:36:0) after 1m0s
[22:31:55.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:36:0)
[22:31:55.657] Timer tick, asking Buildbucket for the build status
[22:31:55.796] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:55.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:37:0) after 1m0s
[22:32:55.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:37:0)
[22:32:55.813] Timer tick, asking Buildbucket for the build status
[22:32:55.869] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:55.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:38:0) after 1m0s
[22:33:55.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:38:0)
[22:33:55.885] Timer tick, asking Buildbucket for the build status
[22:33:55.952] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:55.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:39:0) after 1m0s
[22:34:55.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:39:0)
[22:34:55.969] Timer tick, asking Buildbucket for the build status
[22:34:56.023] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:56.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:40:0) after 1m0s
[22:35:56.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:40:0)
[22:35:56.044] Timer tick, asking Buildbucket for the build status
[22:35:56.192] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:56.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:41:0) after 1m0s
[22:36:56.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:41:0)
[22:36:56.216] Timer tick, asking Buildbucket for the build status
[22:36:56.274] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:56.274] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:42:0) after 1m0s
[22:37:56.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:42:0)
[22:37:56.307] Timer tick, asking Buildbucket for the build status
[22:37:56.369] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:56.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:43:0) after 1m0s
[22:38:56.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:43:0)
[22:38:56.399] Timer tick, asking Buildbucket for the build status
[22:38:56.435] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:56.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:44:0) after 1m0s
[22:39:56.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:44:0)
[22:39:56.451] Timer tick, asking Buildbucket for the build status
[22:39:56.504] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:56.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:45:0) after 1m0s
[22:40:56.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:45:0)
[22:40:56.532] Timer tick, asking Buildbucket for the build status
[22:40:56.585] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:56.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:46:0) after 1m0s
[22:41:56.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:46:0)
[22:41:56.631] Timer tick, asking Buildbucket for the build status
[22:41:56.689] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:56.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:47:0) after 1m0s
[22:42:56.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:47:0)
[22:42:56.733] Timer tick, asking Buildbucket for the build status
[22:42:56.803] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:56.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:48:0) after 1m0s
[22:43:56.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:48:0)
[22:43:56.819] Timer tick, asking Buildbucket for the build status
[22:43:56.939] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:56.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:49:0) after 1m0s
[22:44:56.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:49:0)
[22:44:56.955] Timer tick, asking Buildbucket for the build status
[22:44:57.074] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:57.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:50:0) after 1m0s
[22:45:57.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:50:0)
[22:45:57.144] Timer tick, asking Buildbucket for the build status
[22:45:57.203] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:57.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:51:0) after 1m0s
[22:46:57.225] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:51:0)
[22:46:57.225] Timer tick, asking Buildbucket for the build status
[22:46:57.369] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:57.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:52:0) after 1m0s
[22:47:57.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:52:0)
[22:47:57.390] Timer tick, asking Buildbucket for the build status
[22:47:57.560] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:57.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:53:0) after 1m0s
[22:48:57.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:53:0)
[22:48:57.563] Timer tick, asking Buildbucket for the build status
[22:48:57.730] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:57.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:54:0) after 1m0s
[22:49:57.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:54:0)
[22:49:57.818] Timer tick, asking Buildbucket for the build status
[22:49:57.877] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:57.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:55:0) after 1m0s
[22:50:57.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:55:0)
[22:50:57.893] Timer tick, asking Buildbucket for the build status
[22:50:57.955] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:57.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:56:0) after 1m0s
[22:51:57.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:56:0)
[22:51:57.973] Timer tick, asking Buildbucket for the build status
[22:51:58.055] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:58.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:57:0) after 1m0s
[22:52:58.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:57:0)
[22:52:58.073] Timer tick, asking Buildbucket for the build status
[22:52:58.130] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:58.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:58:0) after 1m0s
[22:53:58.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:58:0)
[22:53:58.146] Timer tick, asking Buildbucket for the build status
[22:53:58.221] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:58.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:59:0) after 1m0s
[22:54:58.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:59:0)
[22:54:58.220] Timer tick, asking Buildbucket for the build status
[22:54:58.331] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:58.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:60:0) after 1m0s
[22:55:58.623] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:60:0)
[22:55:58.623] Timer tick, asking Buildbucket for the build status
[22:55:58.780] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:58.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:61:0) after 1m0s
[22:56:58.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:61:0)
[22:56:58.875] Timer tick, asking Buildbucket for the build status
[22:56:58.961] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:58.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:62:0) after 1m0s
[22:57:58.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:62:0)
[22:57:58.996] Timer tick, asking Buildbucket for the build status
[22:57:59.051] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:59.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:63:0) after 1m0s
[22:58:59.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:63:0)
[22:58:59.069] Timer tick, asking Buildbucket for the build status
[22:58:59.137] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:59.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:64:0) after 1m0s
[22:59:59.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:64:0)
[22:59:59.164] Timer tick, asking Buildbucket for the build status
[22:59:59.327] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:59.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:65:0) after 1m0s
[23:00:59.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:65:0)
[23:00:59.346] Timer tick, asking Buildbucket for the build status
[23:00:59.454] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:59.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:66:0) after 1m0s
[23:01:59.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:66:0)
[23:01:59.517] Timer tick, asking Buildbucket for the build status
[23:01:59.579] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:59.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:67:0) after 1m0s
[23:02:59.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:67:0)
[23:02:59.595] Timer tick, asking Buildbucket for the build status
[23:02:59.680] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:59.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:68:0) after 1m0s
[23:03:59.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:68:0)
[23:03:59.702] Timer tick, asking Buildbucket for the build status
[23:03:59.754] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:59.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:69:0) after 1m0s
[23:04:59.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:69:0)
[23:04:59.799] Timer tick, asking Buildbucket for the build status
[23:04:59.995] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:59.995] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:70:0) after 1m0s
[23:06:00.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:70:0)
[23:06:00.026] Timer tick, asking Buildbucket for the build status
[23:06:00.069] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:00.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:71:0) after 1m0s
[23:07:00.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:71:0)
[23:07:00.107] Timer tick, asking Buildbucket for the build status
[23:07:00.162] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:00.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:72:0) after 1m0s
[23:08:00.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:72:0)
[23:08:00.200] Timer tick, asking Buildbucket for the build status
[23:08:00.273] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:00.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:73:0) after 1m0s
[23:09:00.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:73:0)
[23:09:00.292] Timer tick, asking Buildbucket for the build status
[23:09:00.337] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:00.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:74:0) after 1m0s
[23:10:00.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:74:0)
[23:10:00.376] Timer tick, asking Buildbucket for the build status
[23:10:00.445] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:00.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:75:0) after 1m0s
[23:11:00.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:75:0)
[23:11:00.482] Timer tick, asking Buildbucket for the build status
[23:11:00.534] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:00.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:76:0) after 1m0s
[23:12:00.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:76:0)
[23:12:00.549] Timer tick, asking Buildbucket for the build status
[23:12:00.755] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:00.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:77:0) after 1m0s
[23:13:00.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:77:0)
[23:13:00.820] Timer tick, asking Buildbucket for the build status
[23:13:01.233] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:01.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:78:0) after 1m0s
[23:14:01.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:78:0)
[23:14:01.288] Timer tick, asking Buildbucket for the build status
[23:14:01.372] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:01.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:79:0) after 1m0s
[23:15:01.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:79:0)
[23:15:01.389] Timer tick, asking Buildbucket for the build status
[23:15:01.461] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:01.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:80:0) after 1m0s
[23:16:01.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:80:0)
[23:16:01.482] Timer tick, asking Buildbucket for the build status
[23:16:01.549] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:01.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:81:0) after 1m0s
[23:17:01.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:81:0)
[23:17:01.571] Timer tick, asking Buildbucket for the build status
[23:17:01.628] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:01.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:82:0) after 1m0s
[23:18:01.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:82:0)
[23:18:01.648] Timer tick, asking Buildbucket for the build status
[23:18:01.800] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:01.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:83:0) after 1m0s
[23:19:01.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:83:0)
[23:19:01.816] Timer tick, asking Buildbucket for the build status
[23:19:01.929] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:01.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:84:0) after 1m0s
[23:20:01.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:84:0)
[23:20:01.959] Timer tick, asking Buildbucket for the build status
[23:20:02.181] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:02.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:85:0) after 1m0s
[23:21:02.200] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:85:0)
[23:21:02.200] Timer tick, asking Buildbucket for the build status
[23:21:02.306] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:02.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:86:0) after 1m0s
[23:22:02.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:86:0)
[23:22:02.378] Timer tick, asking Buildbucket for the build status
[23:22:02.449] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:02.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:87:0) after 1m0s
[23:23:02.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:87:0)
[23:23:02.469] Timer tick, asking Buildbucket for the build status
[23:23:02.651] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:02.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:88:0) after 1m0s
[23:24:02.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:88:0)
[23:24:02.669] Timer tick, asking Buildbucket for the build status
[23:24:02.730] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:02.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:89:0) after 1m0s
[23:25:02.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:89:0)
[23:25:02.748] Timer tick, asking Buildbucket for the build status
[23:25:02.833] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:02.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:90:0) after 1m0s
[23:26:02.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:90:0)
[23:26:02.876] Timer tick, asking Buildbucket for the build status
[23:26:02.978] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:02.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:91:0) after 1m0s
[23:27:03.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:91:0)
[23:27:03.079] Timer tick, asking Buildbucket for the build status
[23:27:03.208] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:03.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:92:0) after 1m0s
[23:28:03.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:92:0)
[23:28:03.334] Timer tick, asking Buildbucket for the build status
[23:28:05.188] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:05.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:93:0) after 1m0s
[23:29:05.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:93:0)
[23:29:05.208] Timer tick, asking Buildbucket for the build status
[23:29:05.267] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:05.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:94:0) after 1m0s
[23:30:05.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:94:0)
[23:30:05.283] Timer tick, asking Buildbucket for the build status
[23:30:05.353] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:05.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:95:0) after 1m0s
[23:31:05.369] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:95:0)
[23:31:05.369] Timer tick, asking Buildbucket for the build status
[23:31:05.467] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:05.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:96:0) after 1m0s
[23:32:05.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:96:0)
[23:32:05.483] Timer tick, asking Buildbucket for the build status
[23:32:05.580] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:05.580] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:97:0) after 1m0s
[23:33:05.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:97:0)
[23:33:05.598] Timer tick, asking Buildbucket for the build status
[23:33:05.655] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:05.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:98:0) after 1m0s
[23:34:05.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:98:0)
[23:34:05.677] Timer tick, asking Buildbucket for the build status
[23:34:05.781] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:05.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:99:0) after 1m0s
[23:35:05.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:99:0)
[23:35:05.798] Timer tick, asking Buildbucket for the build status
[23:35:05.865] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:05.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:100:0) after 1m0s
[23:36:05.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:100:0)
[23:36:05.937] Timer tick, asking Buildbucket for the build status
[23:36:05.972] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:05.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:101:0) after 1m0s
[23:37:06.033] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:101:0)
[23:37:06.033] Timer tick, asking Buildbucket for the build status
[23:37:06.353] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:06.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:102:0) after 1m0s
[23:38:06.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:102:0)
[23:38:06.413] Timer tick, asking Buildbucket for the build status
[23:38:06.477] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:06.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:103:0) after 1m0s
[23:39:06.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:103:0)
[23:39:06.505] Timer tick, asking Buildbucket for the build status
[23:39:06.558] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:06.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:104:0) after 1m0s
[23:40:06.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:104:0)
[23:40:06.603] Timer tick, asking Buildbucket for the build status
[23:40:06.711] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:06.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:105:0) after 1m0s
[23:41:06.738] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:105:0)
[23:41:06.738] Timer tick, asking Buildbucket for the build status
[23:41:06.792] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:06.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:106:0) after 1m0s
[23:42:06.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:106:0)
[23:42:06.809] Timer tick, asking Buildbucket for the build status
[23:42:07.060] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:07.060] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:107:0) after 1m0s
[23:43:07.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:107:0)
[23:43:07.081] Timer tick, asking Buildbucket for the build status
[23:43:07.164] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:07.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:108:0) after 1m0s
[23:44:07.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:108:0)
[23:44:07.186] Timer tick, asking Buildbucket for the build status
[23:44:07.243] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:07.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:109:0) after 1m0s
[23:45:07.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:109:0)
[23:45:07.273] Timer tick, asking Buildbucket for the build status
[23:45:07.367] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:07.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:110:0) after 1m0s
[23:46:07.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:110:0)
[23:46:07.401] Timer tick, asking Buildbucket for the build status
[23:46:07.602] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:07.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:111:0) after 1m0s
[23:47:07.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:111:0)
[23:47:07.581] Timer tick, asking Buildbucket for the build status
[23:47:07.633] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:07.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:112:0) after 1m0s
[23:48:07.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:112:0)
[23:48:07.649] Timer tick, asking Buildbucket for the build status
[23:48:07.839] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:07.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:113:0) after 1m0s
[23:49:07.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:113:0)
[23:49:07.857] Timer tick, asking Buildbucket for the build status
[23:49:07.968] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:07.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:114:0) after 1m0s
[23:50:07.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:114:0)
[23:50:07.985] Timer tick, asking Buildbucket for the build status
[23:50:08.107] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:115:0) after 1m0s
[23:51:08.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:115:0)
[23:51:08.152] Timer tick, asking Buildbucket for the build status
[23:51:08.215] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:08.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:116:0) after 1m0s
[23:52:08.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:116:0)
[23:52:08.276] Timer tick, asking Buildbucket for the build status
[23:52:08.493] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:08.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:117:0) after 1m0s
[23:53:08.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:117:0)
[23:53:08.515] Timer tick, asking Buildbucket for the build status
[23:53:08.602] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:08.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:118:0) after 1m0s
[23:54:08.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:118:0)
[23:54:08.618] Timer tick, asking Buildbucket for the build status
[23:54:08.675] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:08.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:119:0) after 1m0s
[23:55:08.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:119:0)
[23:55:08.698] Timer tick, asking Buildbucket for the build status
[23:55:08.842] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:08.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:120:0) after 1m0s
[23:56:08.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:120:0)
[23:56:08.868] Timer tick, asking Buildbucket for the build status
[23:56:08.934] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:08.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:121:0) after 1m0s
[23:57:08.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:121:0)
[23:57:08.978] Timer tick, asking Buildbucket for the build status
[23:57:09.134] Build 8923775555437770912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:09.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089205617595702368:122:0) after 1m0s
[23:57:30.238] Received PubSub notification, asking Buildbucket for the build status
[23:57:30.305] Build 8923775555437770912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:57:30.305] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1548028649293134",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548021469613416",
"experimental": true,
"id": "8923775555437770912",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b4a400db5ec1e0a2a3d48c012150f476511cef7b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Android (dbg)\"], \"kvm\": [\"1\"], \"id\": [\"swarm629-c4\"], \"server_version\": [\"4004-c99644c\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"ff15c51d20785fa51c0ef03ccb480b87299acbeb\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"b4a400db5ec1e0a2a3d48c012150f476511cef7b\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"850c0d9aec6bd3f63cb58ff1838380efc112279a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26298}\", \"$build/goma\": {\"jobs\": 150}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#624494}\", \"branch\": \"refs/heads/master\", \"revision\": \"b4a400db5ec1e0a2a3d48c012150f476511cef7b\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Android (dbg)\", \"got_webrtc_revision\": \"74ba99062c48b278675cfe52643719202296fddc\", \"mastername\": \"chromium.android\", \"got_angle_revision\": \"7403dd2cd3764fe96660fe09892e764e9ae1dbca\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1548021469613416, \"tags\": [\"builder:Deterministic Android (dbg)\", \"buildset:commit/git/b4a400db5ec1e0a2a3d48c012150f476511cef7b\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4a400db5ec1e0a2a3d48c012150f476511cef7b\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9089205617595702368\", \"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\": \"8923775555437770912\"}}, \"got_v8_revision\": \"49d3755f33eb8f2e44b2da7ba21556429d6b2493\", \"got_v8_revision_cp\": \"refs/heads/7.3.451@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 3555, \"path_config\": \"generic\", \"bot_id\": \"swarm629-c4\", \"got_buildtools_revision\": \"2f02e1f363b1af2715536f38e239853f04ec1497\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1548021471806261",
"status": "COMPLETED",
"status_changed_ts": "1548028649883174",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/3555",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089205617595702368",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"swarming_dimension:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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)/3555",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923775555437770912",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4a400db5ec1e0a2a3d48c012150f476511cef7b",
"swarming_tag:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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/8923775555437770912/+/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:9089205617595702368",
"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:5746c1addf0a4c286f58c69ab0c42aedaac6b5ff",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4286169e53833110",
"user_agent:luci-scheduler"
],
"updated_ts": "1548028649885694",
"url": "https://ci.chromium.org/b/8923775555437770912",
"utcnow_ts": "1548028650295788"
}
}
[23:57:30.305] Invocation finished in 1h59m42.133224473s with status SUCCEEDED