[15:09:40.725] New invocation is queued and will start shortly
[15:09:41.984] Starting the invocation (attempt 1)
[15:09:42.022] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:09:42.022] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:09:42.022] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9089956070292875840",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"a4abe650ff1aa9c3be4fb89863ab8339c919e03d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9089956070292875840",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"gitiles_ref:refs/heads/master"
]
}
[15:09:42.899] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1547305782099715",
"id": "8924526008187730000",
"lease_expiration_ts": "1547424582710205",
"lease_key": "2038808384",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a4abe650ff1aa9c3be4fb89863ab8339c919e03d\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1547305782807509",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/19558",
"builder:Deterministic Linux",
"buildset:commit/git/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089956070292875840",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_dimension:builder:Deterministic Linux",
"swarming_dimension:caches:builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Deterministic Linux/19558",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8924526008187730000",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:78936430c90e535d92b72ffe36f7aa2860b3ad48",
"swarming_tag:builder:Deterministic Linux",
"swarming_tag:buildset:commit/git/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"swarming_tag:caches:builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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/8924526008187730000/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"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:9089956070292875840",
"swarming_tag:scheduler_job_id:chromium/Deterministic Linux",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:9f8847cf234cbe6115cbbd25abbb7765c24585c3",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:425b6e1516f68710",
"user_agent:luci-scheduler"
],
"updated_ts": "1547305782807585",
"url": "https://ci.chromium.org/b/8924526008187730000",
"utcnow_ts": "1547305782888936"
}
}
[15:09:42.899] Task URL: https://ci.chromium.org/b/8924526008187730000
[15:09:42.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:2:0) after 1m0s
[15:09:44.905] Received PubSub notification, asking Buildbucket for the build status
[15:09:44.945] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:42.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:2:0)
[15:10:42.916] Timer tick, asking Buildbucket for the build status
[15:10:43.023] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:43.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:4:0) after 1m0s
[15:11:43.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:4:0)
[15:11:43.046] Timer tick, asking Buildbucket for the build status
[15:11:43.104] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:43.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:5:0) after 1m0s
[15:12:43.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:5:0)
[15:12:43.121] Timer tick, asking Buildbucket for the build status
[15:12:43.158] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:43.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:6:0) after 1m0s
[15:13:43.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:6:0)
[15:13:43.177] Timer tick, asking Buildbucket for the build status
[15:13:43.235] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:43.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:7:0) after 1m0s
[15:14:43.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:7:0)
[15:14:43.251] Timer tick, asking Buildbucket for the build status
[15:14:43.381] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:43.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:8:0) after 1m0s
[15:15:43.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:8:0)
[15:15:43.397] Timer tick, asking Buildbucket for the build status
[15:15:43.554] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:43.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:9:0) after 1m0s
[15:16:43.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:9:0)
[15:16:43.570] Timer tick, asking Buildbucket for the build status
[15:16:43.643] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:43.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:10:0) after 1m0s
[15:17:43.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:10:0)
[15:17:43.644] Timer tick, asking Buildbucket for the build status
[15:17:43.678] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:43.678] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:11:0) after 1m0s
[15:18:43.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:11:0)
[15:18:43.693] Timer tick, asking Buildbucket for the build status
[15:18:43.785] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:43.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:12:0) after 1m0s
[15:19:43.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:12:0)
[15:19:43.809] Timer tick, asking Buildbucket for the build status
[15:19:43.913] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:43.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:13:0) after 1m0s
[15:20:43.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:13:0)
[15:20:43.953] Timer tick, asking Buildbucket for the build status
[15:20:44.053] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:44.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:14:0) after 1m0s
[15:21:44.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:14:0)
[15:21:44.072] Timer tick, asking Buildbucket for the build status
[15:21:44.193] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:44.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:15:0) after 1m0s
[15:22:44.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:15:0)
[15:22:44.212] Timer tick, asking Buildbucket for the build status
[15:22:44.279] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:44.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:16:0) after 1m0s
[15:23:44.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:16:0)
[15:23:44.297] Timer tick, asking Buildbucket for the build status
[15:23:44.350] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:44.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:17:0) after 1m0s
[15:24:44.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:17:0)
[15:24:44.368] Timer tick, asking Buildbucket for the build status
[15:24:44.438] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:44.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:18:0) after 1m0s
[15:25:44.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:18:0)
[15:25:44.454] Timer tick, asking Buildbucket for the build status
[15:25:44.509] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:44.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:19:0) after 1m0s
[15:26:44.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:19:0)
[15:26:44.528] Timer tick, asking Buildbucket for the build status
[15:26:44.625] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:44.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:20:0) after 1m0s
[15:27:44.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:20:0)
[15:27:44.647] Timer tick, asking Buildbucket for the build status
[15:27:45.122] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:45.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:21:0) after 1m0s
[15:28:45.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:21:0)
[15:28:45.164] Timer tick, asking Buildbucket for the build status
[15:28:45.251] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:45.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:22:0) after 1m0s
[15:29:45.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:22:0)
[15:29:45.267] Timer tick, asking Buildbucket for the build status
[15:29:45.345] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:45.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:23:0) after 1m0s
[15:30:45.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:23:0)
[15:30:45.359] Timer tick, asking Buildbucket for the build status
[15:30:45.436] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:45.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:24:0) after 1m0s
[15:31:45.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:24:0)
[15:31:45.456] Timer tick, asking Buildbucket for the build status
[15:31:45.515] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:25:0) after 1m0s
[15:32:45.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:25:0)
[15:32:45.546] Timer tick, asking Buildbucket for the build status
[15:32:45.704] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:26:0) after 1m0s
[15:33:45.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:26:0)
[15:33:45.723] Timer tick, asking Buildbucket for the build status
[15:33:45.787] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:27:0) after 1m0s
[15:34:45.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:27:0)
[15:34:45.816] Timer tick, asking Buildbucket for the build status
[15:34:45.930] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:28:0) after 1m0s
[15:35:45.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:28:0)
[15:35:45.950] Timer tick, asking Buildbucket for the build status
[15:35:45.990] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:45.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:29:0) after 1m0s
[15:36:46.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:29:0)
[15:36:46.027] Timer tick, asking Buildbucket for the build status
[15:36:46.103] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:30:0) after 1m0s
[15:37:46.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:30:0)
[15:37:46.124] Timer tick, asking Buildbucket for the build status
[15:37:46.189] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.189] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:31:0) after 1m0s
[15:38:46.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:31:0)
[15:38:46.209] Timer tick, asking Buildbucket for the build status
[15:38:46.378] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:32:0) after 1m0s
[15:39:46.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:32:0)
[15:39:46.398] Timer tick, asking Buildbucket for the build status
[15:39:46.455] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:33:0) after 1m0s
[15:40:46.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:33:0)
[15:40:46.479] Timer tick, asking Buildbucket for the build status
[15:40:46.672] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:34:0) after 1m0s
[15:41:46.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:34:0)
[15:41:46.697] Timer tick, asking Buildbucket for the build status
[15:41:46.781] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:46.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:35:0) after 1m0s
[15:42:46.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:35:0)
[15:42:46.798] Timer tick, asking Buildbucket for the build status
[15:42:46.836] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:46.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:36:0) after 1m0s
[15:43:46.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:36:0)
[15:43:46.856] Timer tick, asking Buildbucket for the build status
[15:43:46.919] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:46.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:37:0) after 1m0s
[15:44:46.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:37:0)
[15:44:46.936] Timer tick, asking Buildbucket for the build status
[15:44:47.032] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:47.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:38:0) after 1m0s
[15:45:47.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:38:0)
[15:45:47.055] Timer tick, asking Buildbucket for the build status
[15:45:47.226] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:47.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:39:0) after 1m0s
[15:46:47.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:39:0)
[15:46:47.244] Timer tick, asking Buildbucket for the build status
[15:46:47.289] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:47.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:40:0) after 1m0s
[15:47:47.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:40:0)
[15:47:47.307] Timer tick, asking Buildbucket for the build status
[15:47:47.366] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:47.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:41:0) after 1m0s
[15:48:47.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:41:0)
[15:48:47.398] Timer tick, asking Buildbucket for the build status
[15:48:47.718] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:47.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:42:0) after 1m0s
[15:49:47.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:42:0)
[15:49:47.735] Timer tick, asking Buildbucket for the build status
[15:49:48.089] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:48.089] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:43:0) after 1m0s
[15:50:48.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:43:0)
[15:50:48.112] Timer tick, asking Buildbucket for the build status
[15:50:48.145] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:48.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:44:0) after 1m0s
[15:51:48.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:44:0)
[15:51:48.208] Timer tick, asking Buildbucket for the build status
[15:51:48.242] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:48.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:45:0) after 1m0s
[15:52:48.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:45:0)
[15:52:48.266] Timer tick, asking Buildbucket for the build status
[15:52:48.404] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:48.404] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:46:0) after 1m0s
[15:53:48.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:46:0)
[15:53:48.441] Timer tick, asking Buildbucket for the build status
[15:53:48.507] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:48.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:47:0) after 1m0s
[15:54:48.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:47:0)
[15:54:48.531] Timer tick, asking Buildbucket for the build status
[15:54:48.590] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:48.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:48:0) after 1m0s
[15:55:48.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:48:0)
[15:55:48.607] Timer tick, asking Buildbucket for the build status
[15:55:48.676] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:48.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:49:0) after 1m0s
[15:56:48.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:49:0)
[15:56:48.697] Timer tick, asking Buildbucket for the build status
[15:56:48.797] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:48.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:50:0) after 1m0s
[15:57:48.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:50:0)
[15:57:48.824] Timer tick, asking Buildbucket for the build status
[15:57:48.900] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:48.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:51:0) after 1m0s
[15:58:48.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:51:0)
[15:58:48.921] Timer tick, asking Buildbucket for the build status
[15:58:49.013] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:49.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:52:0) after 1m0s
[15:59:49.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:52:0)
[15:59:49.032] Timer tick, asking Buildbucket for the build status
[15:59:49.098] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:49.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:53:0) after 1m0s
[16:00:49.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:53:0)
[16:00:49.118] Timer tick, asking Buildbucket for the build status
[16:00:49.859] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:49.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:54:0) after 1m0s
[16:01:49.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:54:0)
[16:01:49.877] Timer tick, asking Buildbucket for the build status
[16:01:49.945] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:49.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:55:0) after 1m0s
[16:02:50.047] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:55:0)
[16:02:50.047] Timer tick, asking Buildbucket for the build status
[16:02:50.400] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:50.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:56:0) after 1m0s
[16:03:50.485] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:56:0)
[16:03:50.485] Timer tick, asking Buildbucket for the build status
[16:03:50.552] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:50.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:57:0) after 1m0s
[16:04:50.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:57:0)
[16:04:50.571] Timer tick, asking Buildbucket for the build status
[16:04:50.758] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:50.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:58:0) after 1m0s
[16:05:50.778] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:58:0)
[16:05:50.778] Timer tick, asking Buildbucket for the build status
[16:05:50.866] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:59:0) after 1m0s
[16:06:50.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:59:0)
[16:06:50.887] Timer tick, asking Buildbucket for the build status
[16:06:51.049] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:51.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:60:0) after 1m0s
[16:07:51.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:60:0)
[16:07:51.071] Timer tick, asking Buildbucket for the build status
[16:07:51.129] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:51.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:61:0) after 1m0s
[16:08:51.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:61:0)
[16:08:51.202] Timer tick, asking Buildbucket for the build status
[16:08:51.588] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:51.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:62:0) after 1m0s
[16:09:51.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:62:0)
[16:09:51.670] Timer tick, asking Buildbucket for the build status
[16:09:51.821] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:51.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:63:0) after 1m0s
[16:10:51.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:63:0)
[16:10:51.880] Timer tick, asking Buildbucket for the build status
[16:10:52.105] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:52.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:64:0) after 1m0s
[16:11:52.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:64:0)
[16:11:52.124] Timer tick, asking Buildbucket for the build status
[16:11:52.254] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:52.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:65:0) after 1m0s
[16:12:52.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:65:0)
[16:12:52.280] Timer tick, asking Buildbucket for the build status
[16:12:52.323] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:52.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:66:0) after 1m0s
[16:13:52.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:66:0)
[16:13:52.368] Timer tick, asking Buildbucket for the build status
[16:13:52.447] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:52.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:67:0) after 1m0s
[16:14:52.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:67:0)
[16:14:52.468] Timer tick, asking Buildbucket for the build status
[16:14:52.551] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:52.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:68:0) after 1m0s
[16:15:52.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:68:0)
[16:15:52.570] Timer tick, asking Buildbucket for the build status
[16:15:52.638] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:52.638] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:69:0) after 1m0s
[16:16:52.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:69:0)
[16:16:52.656] Timer tick, asking Buildbucket for the build status
[16:16:52.725] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:52.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:70:0) after 1m0s
[16:17:52.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:70:0)
[16:17:52.754] Timer tick, asking Buildbucket for the build status
[16:17:52.885] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:52.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:71:0) after 1m0s
[16:18:52.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:71:0)
[16:18:52.906] Timer tick, asking Buildbucket for the build status
[16:18:52.955] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:52.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:72:0) after 1m0s
[16:19:52.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:72:0)
[16:19:52.987] Timer tick, asking Buildbucket for the build status
[16:19:53.027] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:53.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:73:0) after 1m0s
[16:20:53.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:73:0)
[16:20:53.049] Timer tick, asking Buildbucket for the build status
[16:20:53.211] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:53.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:74:0) after 1m0s
[16:21:53.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:74:0)
[16:21:53.233] Timer tick, asking Buildbucket for the build status
[16:21:53.307] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:53.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:75:0) after 1m0s
[16:22:53.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:75:0)
[16:22:53.329] Timer tick, asking Buildbucket for the build status
[16:22:53.398] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:53.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:76:0) after 1m0s
[16:23:53.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:76:0)
[16:23:53.422] Timer tick, asking Buildbucket for the build status
[16:23:53.482] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:53.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:77:0) after 1m0s
[16:24:53.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:77:0)
[16:24:53.503] Timer tick, asking Buildbucket for the build status
[16:24:53.723] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:53.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:78:0) after 1m0s
[16:25:53.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:78:0)
[16:25:53.776] Timer tick, asking Buildbucket for the build status
[16:25:53.836] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:53.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:79:0) after 1m0s
[16:26:53.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:79:0)
[16:26:53.862] Timer tick, asking Buildbucket for the build status
[16:26:53.941] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:53.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:80:0) after 1m0s
[16:27:53.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:80:0)
[16:27:53.971] Timer tick, asking Buildbucket for the build status
[16:27:54.096] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:54.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:81:0) after 1m0s
[16:28:54.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:81:0)
[16:28:54.143] Timer tick, asking Buildbucket for the build status
[16:28:54.269] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:54.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:82:0) after 1m0s
[16:29:54.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:82:0)
[16:29:54.292] Timer tick, asking Buildbucket for the build status
[16:29:54.493] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:54.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:83:0) after 1m0s
[16:30:54.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:83:0)
[16:30:54.514] Timer tick, asking Buildbucket for the build status
[16:30:54.558] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:54.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:84:0) after 1m0s
[16:31:54.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:84:0)
[16:31:54.577] Timer tick, asking Buildbucket for the build status
[16:31:54.632] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:54.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:85:0) after 1m0s
[16:32:54.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:85:0)
[16:32:54.653] Timer tick, asking Buildbucket for the build status
[16:32:54.720] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:54.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:86:0) after 1m0s
[16:33:54.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:86:0)
[16:33:54.765] Timer tick, asking Buildbucket for the build status
[16:33:54.852] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:54.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:87:0) after 1m0s
[16:34:54.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:87:0)
[16:34:54.871] Timer tick, asking Buildbucket for the build status
[16:34:54.960] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:54.960] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:88:0) after 1m0s
[16:35:54.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:88:0)
[16:35:54.978] Timer tick, asking Buildbucket for the build status
[16:35:55.086] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:89:0) after 1m0s
[16:36:55.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:89:0)
[16:36:55.107] Timer tick, asking Buildbucket for the build status
[16:36:55.242] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:55.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:90:0) after 1m0s
[16:37:55.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:90:0)
[16:37:55.281] Timer tick, asking Buildbucket for the build status
[16:37:55.348] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:55.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:91:0) after 1m0s
[16:38:55.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:91:0)
[16:38:55.368] Timer tick, asking Buildbucket for the build status
[16:38:55.431] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:55.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:92:0) after 1m0s
[16:39:55.478] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:92:0)
[16:39:55.478] Timer tick, asking Buildbucket for the build status
[16:39:55.521] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:93:0) after 1m0s
[16:40:55.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:93:0)
[16:40:55.540] Timer tick, asking Buildbucket for the build status
[16:40:55.620] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:55.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:94:0) after 1m0s
[16:41:55.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:94:0)
[16:41:55.651] Timer tick, asking Buildbucket for the build status
[16:41:55.840] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:55.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:95:0) after 1m0s
[16:42:55.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:95:0)
[16:42:55.874] Timer tick, asking Buildbucket for the build status
[16:42:56.005] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:56.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:96:0) after 1m0s
[16:43:56.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:96:0)
[16:43:56.032] Timer tick, asking Buildbucket for the build status
[16:43:56.138] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:56.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:97:0) after 1m0s
[16:44:56.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:97:0)
[16:44:56.162] Timer tick, asking Buildbucket for the build status
[16:44:56.390] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:56.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:98:0) after 1m0s
[16:45:56.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:98:0)
[16:45:56.413] Timer tick, asking Buildbucket for the build status
[16:45:56.513] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:56.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:99:0) after 1m0s
[16:46:56.533] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:99:0)
[16:46:56.533] Timer tick, asking Buildbucket for the build status
[16:46:56.708] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:56.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:100:0) after 1m0s
[16:47:56.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:100:0)
[16:47:56.748] Timer tick, asking Buildbucket for the build status
[16:47:56.786] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:56.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:101:0) after 1m0s
[16:48:56.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:101:0)
[16:48:56.809] Timer tick, asking Buildbucket for the build status
[16:48:56.954] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:102:0) after 1m0s
[16:49:56.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:102:0)
[16:49:56.978] Timer tick, asking Buildbucket for the build status
[16:49:57.128] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:57.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:103:0) after 1m0s
[16:50:57.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:103:0)
[16:50:57.153] Timer tick, asking Buildbucket for the build status
[16:50:57.395] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:57.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:104:0) after 1m0s
[16:51:57.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:104:0)
[16:51:57.437] Timer tick, asking Buildbucket for the build status
[16:51:57.483] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:57.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:105:0) after 1m0s
[16:52:57.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:105:0)
[16:52:57.596] Timer tick, asking Buildbucket for the build status
[16:52:57.690] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:57.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:106:0) after 1m0s
[16:53:57.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:106:0)
[16:53:57.710] Timer tick, asking Buildbucket for the build status
[16:53:57.889] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:57.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:107:0) after 1m0s
[16:54:57.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:107:0)
[16:54:57.909] Timer tick, asking Buildbucket for the build status
[16:54:57.970] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:57.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:108:0) after 1m0s
[16:55:58.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:108:0)
[16:55:58.013] Timer tick, asking Buildbucket for the build status
[16:55:58.054] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:58.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:109:0) after 1m0s
[16:56:58.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:109:0)
[16:56:58.076] Timer tick, asking Buildbucket for the build status
[16:56:58.392] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:110:0) after 1m0s
[16:57:58.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:110:0)
[16:57:58.427] Timer tick, asking Buildbucket for the build status
[16:57:58.498] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:58.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:111:0) after 1m0s
[16:58:58.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:111:0)
[16:58:58.521] Timer tick, asking Buildbucket for the build status
[16:58:58.727] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:58.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:112:0) after 1m0s
[16:59:58.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:112:0)
[16:59:58.749] Timer tick, asking Buildbucket for the build status
[16:59:58.797] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:58.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:113:0) after 1m0s
[17:00:58.817] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:113:0)
[17:00:58.817] Timer tick, asking Buildbucket for the build status
[17:00:58.880] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:58.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:114:0) after 1m0s
[17:01:58.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:114:0)
[17:01:58.905] Timer tick, asking Buildbucket for the build status
[17:01:59.103] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:59.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:115:0) after 1m0s
[17:02:59.130] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:115:0)
[17:02:59.130] Timer tick, asking Buildbucket for the build status
[17:02:59.192] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:59.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:116:0) after 1m0s
[17:03:59.226] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:116:0)
[17:03:59.226] Timer tick, asking Buildbucket for the build status
[17:03:59.265] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:59.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:117:0) after 1m0s
[17:04:59.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:117:0)
[17:04:59.287] Timer tick, asking Buildbucket for the build status
[17:04:59.365] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:59.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:118:0) after 1m0s
[17:05:59.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:118:0)
[17:05:59.383] Timer tick, asking Buildbucket for the build status
[17:05:59.420] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:59.420] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:119:0) after 1m0s
[17:06:59.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:119:0)
[17:06:59.444] Timer tick, asking Buildbucket for the build status
[17:06:59.511] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:59.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:120:0) after 1m0s
[17:07:59.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:120:0)
[17:07:59.528] Timer tick, asking Buildbucket for the build status
[17:07:59.582] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:59.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:121:0) after 1m0s
[17:08:59.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:121:0)
[17:08:59.603] Timer tick, asking Buildbucket for the build status
[17:08:59.692] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:59.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:122:0) after 1m0s
[17:09:59.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:122:0)
[17:09:59.715] Timer tick, asking Buildbucket for the build status
[17:09:59.849] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:59.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:123:0) after 1m0s
[17:10:59.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:123:0)
[17:10:59.870] Timer tick, asking Buildbucket for the build status
[17:10:59.948] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:59.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:124:0) after 1m0s
[17:11:59.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:124:0)
[17:11:59.980] Timer tick, asking Buildbucket for the build status
[17:12:00.027] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:00.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:125:0) after 1m0s
[17:13:00.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:125:0)
[17:13:00.052] Timer tick, asking Buildbucket for the build status
[17:13:00.297] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:00.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:126:0) after 1m0s
[17:14:00.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:126:0)
[17:14:00.318] Timer tick, asking Buildbucket for the build status
[17:14:00.399] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:00.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:127:0) after 1m0s
[17:15:00.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:127:0)
[17:15:00.429] Timer tick, asking Buildbucket for the build status
[17:15:00.549] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:00.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:128:0) after 1m0s
[17:16:00.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:128:0)
[17:16:00.572] Timer tick, asking Buildbucket for the build status
[17:16:00.614] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:00.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:129:0) after 1m0s
[17:17:00.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:129:0)
[17:17:00.639] Timer tick, asking Buildbucket for the build status
[17:17:00.720] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:00.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:130:0) after 1m0s
[17:18:00.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:130:0)
[17:18:00.743] Timer tick, asking Buildbucket for the build status
[17:18:01.291] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:01.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:131:0) after 1m0s
[17:19:01.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:131:0)
[17:19:01.309] Timer tick, asking Buildbucket for the build status
[17:19:01.360] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:01.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:132:0) after 1m0s
[17:20:01.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:132:0)
[17:20:01.400] Timer tick, asking Buildbucket for the build status
[17:20:01.442] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:01.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:133:0) after 1m0s
[17:21:01.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:133:0)
[17:21:01.503] Timer tick, asking Buildbucket for the build status
[17:21:01.561] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:01.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:134:0) after 1m0s
[17:22:01.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:134:0)
[17:22:01.588] Timer tick, asking Buildbucket for the build status
[17:22:01.798] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:01.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:135:0) after 1m0s
[17:23:01.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:135:0)
[17:23:01.821] Timer tick, asking Buildbucket for the build status
[17:23:02.145] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:02.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:136:0) after 1m0s
[17:24:02.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:136:0)
[17:24:02.170] Timer tick, asking Buildbucket for the build status
[17:24:02.215] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:02.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:137:0) after 1m0s
[17:25:02.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:137:0)
[17:25:02.249] Timer tick, asking Buildbucket for the build status
[17:25:02.334] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:02.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:138:0) after 1m0s
[17:26:02.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:138:0)
[17:26:02.371] Timer tick, asking Buildbucket for the build status
[17:26:02.543] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:02.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:139:0) after 1m0s
[17:27:02.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:139:0)
[17:27:02.563] Timer tick, asking Buildbucket for the build status
[17:27:02.942] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:02.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:140:0) after 1m0s
[17:28:03.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:140:0)
[17:28:03.064] Timer tick, asking Buildbucket for the build status
[17:28:03.118] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:03.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:141:0) after 1m0s
[17:29:03.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:141:0)
[17:29:03.221] Timer tick, asking Buildbucket for the build status
[17:29:03.577] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:03.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:142:0) after 1m0s
[17:30:03.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:142:0)
[17:30:03.603] Timer tick, asking Buildbucket for the build status
[17:30:03.693] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:03.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:143:0) after 1m0s
[17:31:03.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:143:0)
[17:31:03.722] Timer tick, asking Buildbucket for the build status
[17:31:03.914] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:03.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:144:0) after 1m0s
[17:32:03.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:144:0)
[17:32:03.937] Timer tick, asking Buildbucket for the build status
[17:32:03.986] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:03.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:145:0) after 1m0s
[17:33:04.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:145:0)
[17:33:04.064] Timer tick, asking Buildbucket for the build status
[17:33:04.227] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:04.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:146:0) after 1m0s
[17:34:04.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:146:0)
[17:34:04.249] Timer tick, asking Buildbucket for the build status
[17:34:04.322] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:04.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:147:0) after 1m0s
[17:35:04.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:147:0)
[17:35:04.344] Timer tick, asking Buildbucket for the build status
[17:35:04.498] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:148:0) after 1m0s
[17:36:04.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:148:0)
[17:36:04.526] Timer tick, asking Buildbucket for the build status
[17:36:04.968] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:04.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:149:0) after 1m0s
[17:37:04.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:149:0)
[17:37:04.992] Timer tick, asking Buildbucket for the build status
[17:37:05.105] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:05.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:150:0) after 1m0s
[17:38:05.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:150:0)
[17:38:05.127] Timer tick, asking Buildbucket for the build status
[17:38:05.208] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:05.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:151:0) after 1m0s
[17:39:05.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:151:0)
[17:39:05.246] Timer tick, asking Buildbucket for the build status
[17:39:05.325] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:05.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:152:0) after 1m0s
[17:40:05.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:152:0)
[17:40:05.349] Timer tick, asking Buildbucket for the build status
[17:40:05.421] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:05.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:153:0) after 1m0s
[17:41:05.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:153:0)
[17:41:05.445] Timer tick, asking Buildbucket for the build status
[17:41:05.502] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:05.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:154:0) after 1m0s
[17:42:05.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:154:0)
[17:42:05.524] Timer tick, asking Buildbucket for the build status
[17:42:05.646] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:05.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:155:0) after 1m0s
[17:43:05.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:155:0)
[17:43:05.676] Timer tick, asking Buildbucket for the build status
[17:43:05.721] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:05.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:156:0) after 1m0s
[17:44:05.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:156:0)
[17:44:05.741] Timer tick, asking Buildbucket for the build status
[17:44:05.783] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:05.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:157:0) after 1m0s
[17:45:05.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:157:0)
[17:45:05.890] Timer tick, asking Buildbucket for the build status
[17:45:06.017] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:06.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:158:0) after 1m0s
[17:46:06.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:158:0)
[17:46:06.055] Timer tick, asking Buildbucket for the build status
[17:46:06.161] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:06.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:159:0) after 1m0s
[17:47:06.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:159:0)
[17:47:06.272] Timer tick, asking Buildbucket for the build status
[17:47:06.331] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:160:0) after 1m0s
[17:48:06.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:160:0)
[17:48:06.360] Timer tick, asking Buildbucket for the build status
[17:48:06.399] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:06.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:161:0) after 1m0s
[17:49:06.426] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:161:0)
[17:49:06.426] Timer tick, asking Buildbucket for the build status
[17:49:06.491] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:06.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:162:0) after 1m0s
[17:50:06.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:162:0)
[17:50:06.516] Timer tick, asking Buildbucket for the build status
[17:50:06.571] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:06.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:163:0) after 1m0s
[17:51:06.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:163:0)
[17:51:06.597] Timer tick, asking Buildbucket for the build status
[17:51:06.873] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:06.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:164:0) after 1m0s
[17:52:06.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:164:0)
[17:52:06.896] Timer tick, asking Buildbucket for the build status
[17:52:07.005] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:07.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:165:0) after 1m0s
[17:53:07.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:165:0)
[17:53:07.026] Timer tick, asking Buildbucket for the build status
[17:53:07.073] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:07.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:166:0) after 1m0s
[17:54:07.100] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:166:0)
[17:54:07.100] Timer tick, asking Buildbucket for the build status
[17:54:07.197] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:07.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:167:0) after 1m0s
[17:55:07.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:167:0)
[17:55:07.219] Timer tick, asking Buildbucket for the build status
[17:55:07.493] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:07.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:168:0) after 1m0s
[17:56:07.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:168:0)
[17:56:07.515] Timer tick, asking Buildbucket for the build status
[17:56:08.689] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:08.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:169:0) after 1m0s
[17:57:08.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:169:0)
[17:57:08.714] Timer tick, asking Buildbucket for the build status
[17:57:08.978] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:08.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:170:0) after 1m0s
[17:58:09.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:170:0)
[17:58:09.026] Timer tick, asking Buildbucket for the build status
[17:58:09.119] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:09.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:171:0) after 1m0s
[17:59:09.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:171:0)
[17:59:09.137] Timer tick, asking Buildbucket for the build status
[17:59:09.178] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:09.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:172:0) after 1m0s
[18:00:09.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:172:0)
[18:00:09.204] Timer tick, asking Buildbucket for the build status
[18:00:09.242] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:09.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:173:0) after 1m0s
[18:01:09.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:173:0)
[18:01:09.283] Timer tick, asking Buildbucket for the build status
[18:01:09.392] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:09.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:174:0) after 1m0s
[18:02:09.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:174:0)
[18:02:09.418] Timer tick, asking Buildbucket for the build status
[18:02:09.480] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:09.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:175:0) after 1m0s
[18:03:09.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:175:0)
[18:03:09.502] Timer tick, asking Buildbucket for the build status
[18:03:09.542] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:09.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:176:0) after 1m0s
[18:04:09.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:176:0)
[18:04:09.571] Timer tick, asking Buildbucket for the build status
[18:04:09.662] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:09.662] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:177:0) after 1m0s
[18:05:09.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:177:0)
[18:05:09.682] Timer tick, asking Buildbucket for the build status
[18:05:09.798] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:09.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:178:0) after 1m0s
[18:06:09.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:178:0)
[18:06:09.844] Timer tick, asking Buildbucket for the build status
[18:06:09.900] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:09.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:179:0) after 1m0s
[18:07:09.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:179:0)
[18:07:09.956] Timer tick, asking Buildbucket for the build status
[18:07:10.043] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:10.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:180:0) after 1m0s
[18:08:10.068] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:180:0)
[18:08:10.068] Timer tick, asking Buildbucket for the build status
[18:08:10.563] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:10.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:181:0) after 1m0s
[18:09:10.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:181:0)
[18:09:10.606] Timer tick, asking Buildbucket for the build status
[18:09:11.023] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:11.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:182:0) after 1m0s
[18:10:11.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:182:0)
[18:10:11.046] Timer tick, asking Buildbucket for the build status
[18:10:11.155] Build 8924526008187730000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:11.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9089956070292875840:183:0) after 1m0s
[18:10:48.244] Received PubSub notification, asking Buildbucket for the build status
[18:10:48.299] Build 8924526008187730000: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[18:10:48.299] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1547316646573283",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1547305782099715",
"failure_reason": "INFRA_FAILURE",
"id": "8924526008187730000",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a4abe650ff1aa9c3be4fb89863ab8339c919e03d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Linux\"], \"kvm\": [\"0\"], \"id\": [\"swarm591-c4\"], \"server_version\": [\"3986-3c043d8\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1547305783988675",
"status": "COMPLETED",
"status_changed_ts": "1547316647913592",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/19558",
"builder:Deterministic Linux",
"buildset:commit/git/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089956070292875840",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_dimension:builder:Deterministic Linux",
"swarming_dimension:caches:builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Deterministic Linux/19558",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8924526008187730000",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:78936430c90e535d92b72ffe36f7aa2860b3ad48",
"swarming_tag:builder:Deterministic Linux",
"swarming_tag:buildset:commit/git/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4abe650ff1aa9c3be4fb89863ab8339c919e03d",
"swarming_tag:caches:builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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/8924526008187730000/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"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:9089956070292875840",
"swarming_tag:scheduler_job_id:chromium/Deterministic Linux",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:9f8847cf234cbe6115cbbd25abbb7765c24585c3",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:425b6e1516f68710",
"user_agent:luci-scheduler"
],
"updated_ts": "1547316647914434",
"url": "https://ci.chromium.org/b/8924526008187730000",
"utcnow_ts": "1547316648287042"
}
}
[18:10:48.299] Invocation finished in 3h1m7.591832147s with status FAILED