[02:31:04.111] New invocation is queued and will start shortly
[02:31:05.495] Starting the invocation (attempt 1)
[02:31:05.543] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:31:05.544] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:31:05.544] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9095439615905020656",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"46b965151aba42fdb96d97a3173115e13e955bf2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9095439615905020656",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/46b965151aba42fdb96d97a3173115e13e955bf2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b965151aba42fdb96d97a3173115e13e955bf2",
"gitiles_ref:refs/heads/master"
]
}
[02:31:07.393] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542076265643226",
"id": "8930009553634968704",
"lease_expiration_ts": "1542195067033963",
"lease_key": "2018374061",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"46b965151aba42fdb96d97a3173115e13e955bf2\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1542076267215037",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/17746",
"builder:Deterministic Linux",
"buildset:commit/git/46b965151aba42fdb96d97a3173115e13e955bf2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b965151aba42fdb96d97a3173115e13e955bf2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095439615905020656",
"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/17746",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8930009553634968704",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:fe0fa9573cfd109a8acd808bd17ad88c768df4a3",
"swarming_tag:builder:Deterministic Linux",
"swarming_tag:buildset:commit/git/46b965151aba42fdb96d97a3173115e13e955bf2",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b965151aba42fdb96d97a3173115e13e955bf2",
"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/8930009553634968704/+/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:9095439615905020656",
"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:94a335d3e4f9666df99531585ddf97d31aa6a83c",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4123b9ffa99f0910",
"user_agent:luci-scheduler"
],
"updated_ts": "1542076267215162",
"url": "https://ci.chromium.org/b/8930009553634968704",
"utcnow_ts": "1542076267380787"
}
}
[02:31:07.393] Task URL: https://ci.chromium.org/b/8930009553634968704
[02:31:07.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:2:0) after 1m0s
[02:31:07.983] Received PubSub notification, asking Buildbucket for the build status
[02:31:08.075] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:07.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:2:0)
[02:32:07.413] Timer tick, asking Buildbucket for the build status
[02:32:07.658] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:07.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:4:0) after 1m0s
[02:33:07.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:4:0)
[02:33:07.675] Timer tick, asking Buildbucket for the build status
[02:33:07.718] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:07.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:5:0) after 1m0s
[02:34:07.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:5:0)
[02:34:07.733] Timer tick, asking Buildbucket for the build status
[02:34:07.795] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:07.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:6:0) after 1m0s
[02:35:07.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:6:0)
[02:35:07.822] Timer tick, asking Buildbucket for the build status
[02:35:07.865] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:07.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:7:0) after 1m0s
[02:36:07.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:7:0)
[02:36:07.894] Timer tick, asking Buildbucket for the build status
[02:36:07.970] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:07.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:8:0) after 1m0s
[02:37:07.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:8:0)
[02:37:07.989] Timer tick, asking Buildbucket for the build status
[02:37:08.032] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:08.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:9:0) after 1m0s
[02:38:08.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:9:0)
[02:38:08.052] Timer tick, asking Buildbucket for the build status
[02:38:08.209] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:08.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:10:0) after 1m0s
[02:39:08.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:10:0)
[02:39:08.236] Timer tick, asking Buildbucket for the build status
[02:39:08.289] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:08.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:11:0) after 1m0s
[02:40:08.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:11:0)
[02:40:08.314] Timer tick, asking Buildbucket for the build status
[02:40:08.376] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:08.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:12:0) after 1m0s
[02:41:08.396] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:12:0)
[02:41:08.396] Timer tick, asking Buildbucket for the build status
[02:41:08.427] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:08.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:13:0) after 1m0s
[02:42:08.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:13:0)
[02:42:08.497] Timer tick, asking Buildbucket for the build status
[02:42:08.576] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:08.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:14:0) after 1m0s
[02:43:08.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:14:0)
[02:43:08.604] Timer tick, asking Buildbucket for the build status
[02:43:08.651] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:08.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:15:0) after 1m0s
[02:44:08.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:15:0)
[02:44:08.671] Timer tick, asking Buildbucket for the build status
[02:44:08.743] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:08.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:16:0) after 1m0s
[02:45:08.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:16:0)
[02:45:08.762] Timer tick, asking Buildbucket for the build status
[02:45:08.809] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:08.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:17:0) after 1m0s
[02:46:08.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:17:0)
[02:46:08.829] Timer tick, asking Buildbucket for the build status
[02:46:08.901] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:18:0) after 1m0s
[02:47:08.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:18:0)
[02:47:08.981] Timer tick, asking Buildbucket for the build status
[02:47:09.044] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:09.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:19:0) after 1m0s
[02:48:09.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:19:0)
[02:48:09.101] Timer tick, asking Buildbucket for the build status
[02:48:09.250] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:09.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:20:0) after 1m0s
[02:49:09.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:20:0)
[02:49:09.459] Timer tick, asking Buildbucket for the build status
[02:49:09.573] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:09.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:21:0) after 1m0s
[02:50:09.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:21:0)
[02:50:09.597] Timer tick, asking Buildbucket for the build status
[02:50:09.738] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:09.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:22:0) after 1m0s
[02:51:09.764] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:22:0)
[02:51:09.764] Timer tick, asking Buildbucket for the build status
[02:51:09.804] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:09.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:23:0) after 1m0s
[02:52:09.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:23:0)
[02:52:09.823] Timer tick, asking Buildbucket for the build status
[02:52:09.932] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:09.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:24:0) after 1m0s
[02:53:09.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:24:0)
[02:53:09.989] Timer tick, asking Buildbucket for the build status
[02:53:10.048] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:10.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:25:0) after 1m0s
[02:54:10.068] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:25:0)
[02:54:10.068] Timer tick, asking Buildbucket for the build status
[02:54:10.307] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:10.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:26:0) after 1m0s
[02:55:10.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:26:0)
[02:55:10.331] Timer tick, asking Buildbucket for the build status
[02:55:10.382] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:27:0) after 1m0s
[02:56:10.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:27:0)
[02:56:10.402] Timer tick, asking Buildbucket for the build status
[02:56:10.468] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:10.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:28:0) after 1m0s
[02:57:10.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:28:0)
[02:57:10.508] Timer tick, asking Buildbucket for the build status
[02:57:10.559] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:10.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:29:0) after 1m0s
[02:58:10.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:29:0)
[02:58:10.588] Timer tick, asking Buildbucket for the build status
[02:58:10.674] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:10.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:30:0) after 1m0s
[02:59:10.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:30:0)
[02:59:10.723] Timer tick, asking Buildbucket for the build status
[02:59:10.757] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:10.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:31:0) after 1m0s
[03:00:10.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:31:0)
[03:00:10.775] Timer tick, asking Buildbucket for the build status
[03:00:10.886] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:10.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:32:0) after 1m0s
[03:01:10.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:32:0)
[03:01:10.910] Timer tick, asking Buildbucket for the build status
[03:01:11.053] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:11.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:33:0) after 1m0s
[03:02:11.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:33:0)
[03:02:11.083] Timer tick, asking Buildbucket for the build status
[03:02:11.160] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:11.160] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:34:0) after 1m0s
[03:03:11.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:34:0)
[03:03:11.181] Timer tick, asking Buildbucket for the build status
[03:03:11.376] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:11.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:35:0) after 1m0s
[03:04:11.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:35:0)
[03:04:11.398] Timer tick, asking Buildbucket for the build status
[03:04:11.444] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:11.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:36:0) after 1m0s
[03:05:11.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:36:0)
[03:05:11.549] Timer tick, asking Buildbucket for the build status
[03:05:11.647] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:11.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:37:0) after 1m0s
[03:06:11.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:37:0)
[03:06:11.676] Timer tick, asking Buildbucket for the build status
[03:06:11.721] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:11.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:38:0) after 1m0s
[03:07:11.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:38:0)
[03:07:11.750] Timer tick, asking Buildbucket for the build status
[03:07:11.783] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:11.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:39:0) after 1m0s
[03:08:11.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:39:0)
[03:08:11.810] Timer tick, asking Buildbucket for the build status
[03:08:11.883] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:11.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:40:0) after 1m0s
[03:09:11.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:40:0)
[03:09:11.906] Timer tick, asking Buildbucket for the build status
[03:09:11.965] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:11.965] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:41:0) after 1m0s
[03:10:11.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:41:0)
[03:10:11.996] Timer tick, asking Buildbucket for the build status
[03:10:12.036] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:12.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:42:0) after 1m0s
[03:11:12.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:42:0)
[03:11:12.081] Timer tick, asking Buildbucket for the build status
[03:11:12.155] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:12.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:43:0) after 1m0s
[03:12:12.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:43:0)
[03:12:12.189] Timer tick, asking Buildbucket for the build status
[03:12:12.259] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:12.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:44:0) after 1m0s
[03:13:12.323] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:44:0)
[03:13:12.323] Timer tick, asking Buildbucket for the build status
[03:13:12.435] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:12.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:45:0) after 1m0s
[03:14:12.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:45:0)
[03:14:12.467] Timer tick, asking Buildbucket for the build status
[03:14:12.546] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:12.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:46:0) after 1m0s
[03:15:12.565] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:46:0)
[03:15:12.565] Timer tick, asking Buildbucket for the build status
[03:15:12.607] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:12.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:47:0) after 1m0s
[03:16:12.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:47:0)
[03:16:12.638] Timer tick, asking Buildbucket for the build status
[03:16:12.752] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:12.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:48:0) after 1m0s
[03:17:12.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:48:0)
[03:17:12.775] Timer tick, asking Buildbucket for the build status
[03:17:12.900] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:12.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:49:0) after 1m0s
[03:18:12.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:49:0)
[03:18:12.923] Timer tick, asking Buildbucket for the build status
[03:18:13.105] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:13.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:50:0) after 1m0s
[03:19:13.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:50:0)
[03:19:13.126] Timer tick, asking Buildbucket for the build status
[03:19:13.204] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:13.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:51:0) after 1m0s
[03:20:13.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:51:0)
[03:20:13.236] Timer tick, asking Buildbucket for the build status
[03:20:13.291] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:13.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:52:0) after 1m0s
[03:21:13.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:52:0)
[03:21:13.314] Timer tick, asking Buildbucket for the build status
[03:21:13.452] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:13.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:53:0) after 1m0s
[03:22:13.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:53:0)
[03:22:13.505] Timer tick, asking Buildbucket for the build status
[03:22:13.538] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:13.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:54:0) after 1m0s
[03:23:13.560] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:54:0)
[03:23:13.560] Timer tick, asking Buildbucket for the build status
[03:23:13.723] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:13.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:55:0) after 1m0s
[03:24:13.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:55:0)
[03:24:13.745] Timer tick, asking Buildbucket for the build status
[03:24:13.842] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:13.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:56:0) after 1m0s
[03:25:13.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:56:0)
[03:25:13.923] Timer tick, asking Buildbucket for the build status
[03:25:14.140] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:14.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:57:0) after 1m0s
[03:26:14.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:57:0)
[03:26:14.173] Timer tick, asking Buildbucket for the build status
[03:26:14.272] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:14.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:58:0) after 1m0s
[03:27:14.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:58:0)
[03:27:14.361] Timer tick, asking Buildbucket for the build status
[03:27:14.405] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:14.405] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:59:0) after 1m0s
[03:28:14.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:59:0)
[03:28:14.439] Timer tick, asking Buildbucket for the build status
[03:28:14.471] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:14.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:60:0) after 1m0s
[03:29:14.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:60:0)
[03:29:14.569] Timer tick, asking Buildbucket for the build status
[03:29:14.686] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:14.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:61:0) after 1m0s
[03:30:14.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:61:0)
[03:30:14.730] Timer tick, asking Buildbucket for the build status
[03:30:14.795] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:14.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:62:0) after 1m0s
[03:31:14.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:62:0)
[03:31:14.837] Timer tick, asking Buildbucket for the build status
[03:31:14.919] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:14.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:63:0) after 1m0s
[03:32:14.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:63:0)
[03:32:14.945] Timer tick, asking Buildbucket for the build status
[03:32:15.014] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:15.014] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:64:0) after 1m0s
[03:33:15.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:64:0)
[03:33:15.124] Timer tick, asking Buildbucket for the build status
[03:33:15.170] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:15.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:65:0) after 1m0s
[03:34:15.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:65:0)
[03:34:15.196] Timer tick, asking Buildbucket for the build status
[03:34:15.280] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:15.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:66:0) after 1m0s
[03:35:15.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:66:0)
[03:35:15.313] Timer tick, asking Buildbucket for the build status
[03:35:15.368] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:15.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:67:0) after 1m0s
[03:36:15.406] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:67:0)
[03:36:15.406] Timer tick, asking Buildbucket for the build status
[03:36:15.475] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:15.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:68:0) after 1m0s
[03:37:15.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:68:0)
[03:37:15.508] Timer tick, asking Buildbucket for the build status
[03:37:15.647] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:15.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:69:0) after 1m0s
[03:38:15.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:69:0)
[03:38:15.695] Timer tick, asking Buildbucket for the build status
[03:38:15.842] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:15.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:70:0) after 1m0s
[03:39:15.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:70:0)
[03:39:15.868] Timer tick, asking Buildbucket for the build status
[03:39:15.984] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:15.985] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:71:0) after 1m0s
[03:40:16.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:71:0)
[03:40:16.008] Timer tick, asking Buildbucket for the build status
[03:40:16.069] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:16.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:72:0) after 1m0s
[03:41:16.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:72:0)
[03:41:16.186] Timer tick, asking Buildbucket for the build status
[03:41:16.246] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:16.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:73:0) after 1m0s
[03:42:16.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:73:0)
[03:42:16.300] Timer tick, asking Buildbucket for the build status
[03:42:16.369] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:16.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:74:0) after 1m0s
[03:43:16.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:74:0)
[03:43:16.408] Timer tick, asking Buildbucket for the build status
[03:43:16.469] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:16.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:75:0) after 1m0s
[03:44:16.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:75:0)
[03:44:16.495] Timer tick, asking Buildbucket for the build status
[03:44:16.535] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:16.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:76:0) after 1m0s
[03:45:16.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:76:0)
[03:45:16.658] Timer tick, asking Buildbucket for the build status
[03:45:16.730] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:16.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:77:0) after 1m0s
[03:46:16.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:77:0)
[03:46:16.754] Timer tick, asking Buildbucket for the build status
[03:46:16.822] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:16.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:78:0) after 1m0s
[03:47:16.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:78:0)
[03:47:16.844] Timer tick, asking Buildbucket for the build status
[03:47:16.932] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:16.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:79:0) after 1m0s
[03:48:16.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:79:0)
[03:48:16.966] Timer tick, asking Buildbucket for the build status
[03:48:17.003] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:17.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:80:0) after 1m0s
[03:49:17.033] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:80:0)
[03:49:17.033] Timer tick, asking Buildbucket for the build status
[03:49:17.169] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:17.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:81:0) after 1m0s
[03:50:17.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:81:0)
[03:50:17.197] Timer tick, asking Buildbucket for the build status
[03:50:17.241] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:82:0) after 1m0s
[03:51:17.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:82:0)
[03:51:17.265] Timer tick, asking Buildbucket for the build status
[03:51:17.326] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:17.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:83:0) after 1m0s
[03:52:17.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:83:0)
[03:52:17.363] Timer tick, asking Buildbucket for the build status
[03:52:17.497] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:17.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:84:0) after 1m0s
[03:53:17.551] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:84:0)
[03:53:17.551] Timer tick, asking Buildbucket for the build status
[03:53:17.617] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:17.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:85:0) after 1m0s
[03:54:17.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:85:0)
[03:54:17.644] Timer tick, asking Buildbucket for the build status
[03:54:17.707] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:17.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:86:0) after 1m0s
[03:55:17.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:86:0)
[03:55:17.731] Timer tick, asking Buildbucket for the build status
[03:55:17.798] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:17.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:87:0) after 1m0s
[03:56:17.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:87:0)
[03:56:17.824] Timer tick, asking Buildbucket for the build status
[03:56:17.963] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:17.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:88:0) after 1m0s
[03:57:17.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:88:0)
[03:57:17.992] Timer tick, asking Buildbucket for the build status
[03:57:18.053] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:18.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:89:0) after 1m0s
[03:58:18.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:89:0)
[03:58:18.094] Timer tick, asking Buildbucket for the build status
[03:58:18.149] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:18.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:90:0) after 1m0s
[03:59:18.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:90:0)
[03:59:18.435] Timer tick, asking Buildbucket for the build status
[03:59:18.534] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:18.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:91:0) after 1m0s
[04:00:18.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:91:0)
[04:00:18.555] Timer tick, asking Buildbucket for the build status
[04:00:18.717] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:18.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:92:0) after 1m0s
[04:01:18.840] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:92:0)
[04:01:18.840] Timer tick, asking Buildbucket for the build status
[04:01:18.920] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:18.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:93:0) after 1m0s
[04:02:18.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:93:0)
[04:02:18.943] Timer tick, asking Buildbucket for the build status
[04:02:19.025] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:19.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:94:0) after 1m0s
[04:03:19.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:94:0)
[04:03:19.087] Timer tick, asking Buildbucket for the build status
[04:03:19.193] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:19.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:95:0) after 1m0s
[04:04:19.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:95:0)
[04:04:19.259] Timer tick, asking Buildbucket for the build status
[04:04:19.363] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:19.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:96:0) after 1m0s
[04:05:19.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:96:0)
[04:05:19.393] Timer tick, asking Buildbucket for the build status
[04:05:19.439] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:19.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:97:0) after 1m0s
[04:06:19.461] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:97:0)
[04:06:19.461] Timer tick, asking Buildbucket for the build status
[04:06:19.565] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:19.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:98:0) after 1m0s
[04:07:19.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:98:0)
[04:07:19.586] Timer tick, asking Buildbucket for the build status
[04:07:19.648] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:19.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:99:0) after 1m0s
[04:08:19.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:99:0)
[04:08:19.671] Timer tick, asking Buildbucket for the build status
[04:08:19.720] Build 8930009553634968704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:19.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9095439615905020656:100:0) after 1m0s
[04:08:52.973] Received PubSub notification, asking Buildbucket for the build status
[04:08:53.839] Build 8930009553634968704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:08:53.839] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1542082131695384",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542076265643226",
"id": "8930009553634968704",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"46b965151aba42fdb96d97a3173115e13e955bf2\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Linux\"], \"kvm\": [\"0\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"server_version\": [\"3844-124e68f\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm591-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"46b965151aba42fdb96d97a3173115e13e955bf2\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"597e1587b4bfc7bf89895c7c879ae58b649da3c5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25544}\", \"$build/goma\": {\"jobs\": 500}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#607451}\", \"branch\": \"refs/heads/master\", \"revision\": \"46b965151aba42fdb96d97a3173115e13e955bf2\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Linux\", \"got_webrtc_revision\": \"e769ed90c3599a131166d5a61625c1b64318fb91\", \"mastername\": \"chromium.linux\", \"got_angle_revision\": \"03d1a5ed6cc8ba6a32ffc6fb6d67a3c2da05a6d1\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1542076265643226, \"tags\": [\"builder:Deterministic Linux\", \"buildset:commit/git/46b965151aba42fdb96d97a3173115e13e955bf2\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b965151aba42fdb96d97a3173115e13e955bf2\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9095439615905020656\", \"scheduler_job_id:chromium/Deterministic Linux\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8930009553634968704\"}}, \"got_v8_revision\": \"d5f263024407cc8363474f5770362caaf3d66c87\", \"got_v8_revision_cp\": \"refs/heads/7.2.301@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 17746, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"ee0fbf9331feee6eeebccd4fb58f65c14d729f91\", \"gpu_perftests\": \"1c8085beb2a5a0dd5e418c8d656f9b355c340d1c\", \"telemetry_unittests\": \"7ebac1f6a539619ba2c4597f417da1490eb49747\", \"load_library_perf_tests\": \"d93b7961979325bddbe9c455eded606fc0a24a7d\", \"devtools_closure_compile\": \"466a766c36cf9939035c8b454d023b44845d7d1c\", \"chromedriver_py_tests\": \"9786c7056e1b27252806ce0580f2ab52a412ab11\", \"mojo_core_unittests\": \"140cdb6b44de7cf5c56d0400419e2d178e01551d\", \"leveldb_service_unittests\": \"65c69ea5e760d89bfc842c99e6718ab3b5874b71\", \"storage_unittests\": \"2123867d65d3b4ef97658c22c556cefbd2807e7a\", \"jingle_unittests\": \"e177918ec54adbb127055be461c6b7fd422d40c5\", \"angle_unittests\": \"474f61bfc3836193661e012118b45517eaafa249\", \"cast_unittests\": \"064cd7152bc311f734cd6f3af4db9e54150bfbf8\", \"cc_unittests\": \"ba4e191caa3392a238f562a8007f1f5cb9d17d69\", \"blink_common_unittests\": \"5aca9e7818e978f903a10743f72a5b9f65fadbbe\", \"crashpad_tests\": \"9af0345830e3d765e0c1133277c909cdd1c388b5\", \"telemetry_perf_tests_without_chrome\": \"99b8eda1032bf1d1d846557b3380c607b4c4a5b5\", \"metrics_python_tests\": \"e6d38ad9f88b3c09dbca34b5cf7aed24b945a71d\", \"message_center_unittests\": \"981061857829e904316c25d481c490f18ec8206e\", \"ppapi_unittests\": \"f9dc9839a06fe748631dd31bb81a65e935337809\", \"extensions_unittests\": \"5ba6103cbb83d8606319f14aaa1641087d859b4f\", \"gl_unittests_ozone\": \"a94811e30daf033477aedc73ef16154687b02d74\", \"app_shell_unittests\": \"eac65afe5f6b36a5ed3e285176012dffbc04f864\", \"boringssl_ssl_tests\": \"41369b63ffae1d98e6fe3a56154cae314ebcab67\", \"chrome_app_unittests\": \"99e31b616a1e2eded7fd9a87d2b82b8c72d52d60\", \"gl_unittests\": \"27f1c9a3afe603cc007648f02827805df64a875c\", \"gcm_unit_tests\": \"f7b2868750a004ca9750b657ee28997ac0d58bc6\", \"views_unittests\": \"b640b898e208993210b80611603ae6845e0b5d06\", \"content_shell_crash_test\": \"f2bce45904223c3fd1c4107c277515467f617972\", \"dawn_end2end_tests\": \"a1fe287657a60a2d634aa4eb3a0565d95186a4a2\", \"ui_base_unittests\": \"36e8707f5cb603187cbbcd2a3a07223d01dfe42f\", \"gles2_conform_test\": \"6915e83c3ad4dac7ca2e12ed21c4c1e02f2353c8\", \"cronet_unittests\": \"867c7353cb14ac3e877f60c0fe7e695606c2bb7f\", \"performance_test_suite\": \"26a7847210ad429278d68402913a4b75f436340a\", \"wm_unittests\": \"d667a27423798a4e35968149e6e4e8c1c7e2b6a4\", \"boringssl_crypto_tests\": \"1c27ff339ffc149b267320673a9eec5c5d4d9640\", \"gin_unittests\": \"16c759c2a6ce19a48027c15242fd7357e032c55d\", \"performance_browser_tests\": \"dc06314dfdc9d8f46df5d05e173cbcc0eed34199\", \"extensions_browsertests\": \"02704f87dd02280994ac4fda52b2b8aa88884bd5\", \"webkit_python_tests\": \"4400d3d9c6ae26ce7b7ef50711d859f9d1719eed\", \"headless_unittests\": \"c92d928b909bd817c2266016d3a57d98626ecc34\", \"webkit_layout_tests\": \"77912c2378e881154968e012be734953dbd21f5a\", \"breakpad_unittests\": \"b7c47571ce0e3411778f9fa3aa7fdb6d97cfe800\", \"vr_pixeltests\": \"eba5459f59b6a55ca318b00f2fba1aeb31e83a23\", \"webkit_unit_tests\": \"e00e6d16053a407418e2b2a25d82f06bee16469d\", \"content_unittests\": \"f2f81106e181dac565af03638885b2c9ec864741\", \"performance_webview_test_suite\": \"ccef4b33c0243f7b03baa8af84f77fa650dcedf2\", \"wtf_unittests\": \"afcbaa292528794a977ead8e0a800999c1f7d8a4\", \"webkit_layout_tests_exparchive\": \"87573d22439920c927782eb7eb8b91106b68388b\", \"traffic_annotation_auditor_unittests\": \"0dd76b4805b2b0541548afcbe3f3e44d2be055ab\", \"libjingle_xmpp_unittests\": \"cfe0d472c4ee1034039eb2c35d112411d08632e6\", \"remoting_unittests\": \"24df3ebcda2b92ed0ad3092b4ca5668818658058\", \"vr_common_perftests\": \"260cca5be3c0374068bf68a5220a0699c4b62ce1\", \"filesystem_service_unittests\": \"5aa05ccf235155c789c3e9715d421e17a8623431\", \"gl_tests\": \"b10c88a376369115e160e52090d45e03cd726a05\", \"base_perftests\": \"7bec41347a7b1390b7b2652222d0d23ce3604f73\", \"headless_browsertests\": \"39c81a81d75b8ba9f2bc80533029dd69dbf5982f\", \"capture_unittests\": \"da9892673cbe456d8ddb47f8407125e40ea837b1\", \"telemetry_gpu_unittests\": \"6f709e6e443bc0c589f066f8f47416fa89028a50\", \"command_buffer_perftests\": \"e6f75645443c247a490cb808b7dda43cf9e061ae\", \"media_unittests\": \"9ce2866d7876fa86cb5c3625a11a7771fbac696b\", \"gfx_unittests\": \"8d86056f5de1f4c203e95306f370c894695d2233\", \"chromedriver_unittests\": \"f0357c3729a7f03a59c21808b408cd89056c083a\", \"views_mus_interactive_ui_tests\": \"e6ce8d2cdc44f8c7ff6fffc26847a90170ca52ae\", \"sandbox_linux_unittests\": \"75e8f8e524b9da7e4874dc1786bf0b1e190bd914\", \"media_service_unittests\": \"fe61b21faf9d6ee192522f59d800ceb3cdb81fda\", \"compositor_unittests\": \"380276da77a0996200d0a796577d5175009c833c\", \"latency_unittests\": \"964528ce59969c665299d83420c23cd3e9e99d5e\", \"swiftshader_unittests\": \"63e2ca22ea3d03375e9977cdfc3446d0712296fe\", \"telemetry_perf_unittests\": \"4eaa92173cb43faa1cb53716f78d8c0d220249ac\", \"media_blink_unittests\": \"f2dbaa6673317c0175f0c09b5c70f20153c7ed85\", \"views_mus_unittests\": \"35b0f493babbe9e43280a66f816d1b070ed69fd1\", \"components_unittests\": \"78724b2c94327ad766d99b86f855ca052344bfa4\", \"snapshot_unittests\": \"ffd844e6247508bd4f7b9ba2a7180d73f7fe6454\", \"accessibility_unittests\": \"ddc6cf3a4cfb8f7a3e3a91756d55e6544049e0be\", \"net_perftests\": \"54f0cd0c4577a2e8fcf18e256d5b43510ee33108\", \"aura_unittests\": \"ed6e7f4f65f9c03b14b900a1506535dd6120562f\", \"services_unittests\": \"d15d3779649a5bb41818abfb2f979df53ec31faa\", \"components_perftests\": \"1b8dfb194e47f2ed063b10ffb38e743a8e6ec60c\", \"events_unittests\": \"aa87b35cd50f3189c90a3228ca408270830d0f34\", \"tracing_perftests\": \"8733dcccfd4d1b1c4a8052e648f15a0a8f098229\", \"chromedriver_replay_unittests\": \"80dcdd65faa3e5c2519bd1b938064835370c9584\", \"ui_touch_selection_unittests\": \"7b995d4a480ac1e97380cfe102847abb5f943539\", \"cacheinvalidation_unittests\": \"d098241d1b84ea5bd7d5a1db085ab0f09cbc0248\", \"viz_unittests\": \"a49a3978d4e010090332b6a179a4df151b29ffee\", \"browser_tests\": \"e21db3b7b1f08bd9edc544d5c65e674800f225e0\", \"net_unittests\": \"b8d7f9e209ba918ca2735abd2959492327b72af8\", \"pdf_unittests\": \"8d2bf988b392f3aaa90f1998e4dc2738091451c5\", \"dbus_unittests\": \"d5aefad71e9926106476d030a8a1a1db5c13d79e\", \"vr_common_unittests\": \"c0bff9a05267d300199831df50bfa3a9bbdb6e19\", \"gpu_unittests\": \"d43a7469a49730947dbc8285dce29c67ca4f1537\", \"native_theme_unittests\": \"48e93393b748be055eb2a7e64a33740ba572e3f3\", \"interactive_ui_tests\": \"a867d3042c2566e41925147a60f22b056eff59ca\", \"mojo_unittests\": \"84e83995810a9c54c0dc0ed7eeddc87e6724fa5b\", \"url_unittests\": \"c821d90be45993dd3bf4427c94e6dff702207735\", \"media_perftests\": \"74b3629344d691cddb07e4119ba31cdce8e69c9b\", \"cronet_tests\": \"093e0907da654e8a61140c4d31a2d3d77eeb06dd\", \"google_apis_unittests\": \"25f10e28b83a0211d96c142eed85bc34ebe74039\", \"telemetry_gpu_integration_test\": \"ff8866eee22f77299cb8b9de147e6e293783d19e\", \"blink_heap_unittests\": \"c48ea8ea998b9e9a3a5d304b7970f5ef6fc00158\", \"midi_unittests\": \"52e85e3a02443e8fe4d57d891de83aa3d739f06c\", \"base_unittests\": \"33cba55d026fcb3723bb82dc2e20cdc846a9c6c2\", \"sync_integration_tests\": \"62c61b3fd745cdf46acd95b9048b73a8d6e4c5a5\", \"sql_unittests\": \"54df160d7fd5a76cc29fc0c02d980f3de1781212\", \"nacl_helper_nonsfi_unittests\": \"894cccd4e66b2eeaa18481390aa2878cbea73dbb\", \"blink_fuzzer_unittests\": \"6ad1f5884fcd9735d5123625b92a7635de4588f7\", \"zucchini_unittests\": \"38ddf6c39c95d2ce744161f53a5740397da5fafa\", \"ipc_tests\": \"d94ce9d014d0f8053c94d9b752868df093bce9f1\", \"courgette_unittests\": \"0124c8f5f1c8e17c8fc2f9044ddb2ad85324b143\", \"devtools_eslint\": \"b1bb2d5c22823b94443e9edb47224516568e5760\", \"blink_platform_unittests\": \"e5ced33bda706ceecfb644b978b4e4d8589c7287\", \"components_browsertests\": \"50d7b24b5711662c0e7756e84c89e123662d5190\", \"views_perftests\": \"d7ae7c467862d6863da7d314f0d3ce0306475c45\", \"angle_perftests\": \"5002cbd54e4dc732141bf7111e929145a5a01832\", \"display_unittests\": \"6b4a1d6177cf35d407de91eddb122d35a069f865\", \"service_manager_unittests\": \"a2f56d96d919cefca7fe77d59b8112df5068fb0c\", \"angle_end2end_tests\": \"79477cb754948b1cc3efc1f9fc24b3b4bd30f04d\", \"skia_unittests\": \"39873bc5d9470bf3f1788bf6b7198e4c999f4f2c\", \"angle_white_box_tests\": \"92606f48d959acf824d6ab6689d609ff182ccb07\", \"crypto_unittests\": \"5c06d479e38a0ea22ce1335f10e12203c2773603\", \"nacl_loader_unittests\": \"e8b7b911188c6faf58aa89f705375e5f30d08a9a\", \"unit_tests\": \"8ad3f8f768c45d31f2e44df72c6577199b3e683b\", \"content_browsertests\": \"619214cf586c0f5ed1398b82977a130ff495e077\", \"printing_unittests\": \"e069e6dac7a4a949e3c7315cb70d72e56f957087\", \"device_unittests\": \"cd9e7daa70d06d319a12b623a0827d1ae5d7ada4\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm591-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1542076267048786",
"status": "COMPLETED",
"status_changed_ts": "1542082132458344",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/17746",
"builder:Deterministic Linux",
"buildset:commit/git/46b965151aba42fdb96d97a3173115e13e955bf2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b965151aba42fdb96d97a3173115e13e955bf2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095439615905020656",
"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/17746",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8930009553634968704",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:fe0fa9573cfd109a8acd808bd17ad88c768df4a3",
"swarming_tag:builder:Deterministic Linux",
"swarming_tag:buildset:commit/git/46b965151aba42fdb96d97a3173115e13e955bf2",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b965151aba42fdb96d97a3173115e13e955bf2",
"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/8930009553634968704/+/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:9095439615905020656",
"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:94a335d3e4f9666df99531585ddf97d31aa6a83c",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4123b9ffa99f0910",
"user_agent:luci-scheduler"
],
"updated_ts": "1542082132460662",
"url": "https://ci.chromium.org/b/8930009553634968704",
"utcnow_ts": "1542082133819703"
}
}
[04:08:53.839] Invocation finished in 1h37m49.743848345s with status SUCCEEDED