[02:26:44.199] New invocation is queued and will start shortly
[02:26:45.425] Starting the invocation (attempt 1)
[02:26:45.478] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:26:45.478] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:26:45.478] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9095711679342411264",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9095711679342411264",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"gitiles_ref:refs/heads/master"
]
}
[02:26:47.502] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541816805579380",
"id": "8930281617231222960",
"lease_expiration_ts": "1541935607248493",
"lease_key": "1787483928",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1541816807412431",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/3292",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095711679342411264",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_dimension:builder:Deterministic Linux (dbg)",
"swarming_dimension:caches:builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_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 (dbg)/3292",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8930281617231222960",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c8ae520b7ed0f3687d2af0e926104b1bcbf0f37",
"swarming_tag:builder:Deterministic Linux (dbg)",
"swarming_tag:buildset:commit/git/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"swarming_tag:caches:builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_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/8930281617231222960/+/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:9095711679342411264",
"swarming_tag:scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:43eed580a711b6fa3c17ee91a8c14ff22cb7390f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:411442f5527a0d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1541816807412527",
"url": "https://ci.chromium.org/b/8930281617231222960",
"utcnow_ts": "1541816807488990"
}
}
[02:26:47.502] Task URL: https://ci.chromium.org/b/8930281617231222960
[02:26:47.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:2:0) after 1m0s
[02:27:27.215] Received PubSub notification, asking Buildbucket for the build status
[02:27:27.257] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:47.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:2:0)
[02:27:47.527] Timer tick, asking Buildbucket for the build status
[02:27:47.620] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:47.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:4:0) after 1m0s
[02:28:47.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:4:0)
[02:28:47.640] Timer tick, asking Buildbucket for the build status
[02:28:47.737] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:47.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:5:0) after 1m0s
[02:29:47.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:5:0)
[02:29:47.758] Timer tick, asking Buildbucket for the build status
[02:29:47.821] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:47.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:6:0) after 1m0s
[02:30:47.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:6:0)
[02:30:47.845] Timer tick, asking Buildbucket for the build status
[02:30:47.886] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:47.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:7:0) after 1m0s
[02:31:47.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:7:0)
[02:31:47.911] Timer tick, asking Buildbucket for the build status
[02:31:47.972] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:47.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:8:0) after 1m0s
[02:32:47.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:8:0)
[02:32:47.992] Timer tick, asking Buildbucket for the build status
[02:32:48.044] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:48.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:9:0) after 1m0s
[02:33:48.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:9:0)
[02:33:48.065] Timer tick, asking Buildbucket for the build status
[02:33:48.183] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:48.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:10:0) after 1m0s
[02:34:48.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:10:0)
[02:34:48.317] Timer tick, asking Buildbucket for the build status
[02:34:48.413] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:48.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:11:0) after 1m0s
[02:35:48.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:11:0)
[02:35:48.496] Timer tick, asking Buildbucket for the build status
[02:35:48.564] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:48.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:12:0) after 1m0s
[02:36:48.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:12:0)
[02:36:48.589] Timer tick, asking Buildbucket for the build status
[02:36:48.672] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:48.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:13:0) after 1m0s
[02:37:48.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:13:0)
[02:37:48.743] Timer tick, asking Buildbucket for the build status
[02:37:48.877] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:48.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:14:0) after 1m0s
[02:38:48.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:14:0)
[02:38:48.992] Timer tick, asking Buildbucket for the build status
[02:38:49.093] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:49.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:15:0) after 1m0s
[02:39:49.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:15:0)
[02:39:49.119] Timer tick, asking Buildbucket for the build status
[02:39:49.214] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:49.214] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:16:0) after 1m0s
[02:40:49.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:16:0)
[02:40:49.273] Timer tick, asking Buildbucket for the build status
[02:40:49.387] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:49.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:17:0) after 1m0s
[02:41:49.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:17:0)
[02:41:49.410] Timer tick, asking Buildbucket for the build status
[02:41:49.447] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:49.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:18:0) after 1m0s
[02:42:49.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:18:0)
[02:42:49.467] Timer tick, asking Buildbucket for the build status
[02:42:49.582] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:49.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:19:0) after 1m0s
[02:43:49.605] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:19:0)
[02:43:49.605] Timer tick, asking Buildbucket for the build status
[02:43:49.668] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:49.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:20:0) after 1m0s
[02:44:49.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:20:0)
[02:44:49.689] Timer tick, asking Buildbucket for the build status
[02:44:49.795] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:49.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:21:0) after 1m0s
[02:45:49.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:21:0)
[02:45:49.816] Timer tick, asking Buildbucket for the build status
[02:45:49.860] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:49.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:22:0) after 1m0s
[02:46:49.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:22:0)
[02:46:49.881] Timer tick, asking Buildbucket for the build status
[02:46:49.939] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:49.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:23:0) after 1m0s
[02:47:50.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:23:0)
[02:47:50.024] Timer tick, asking Buildbucket for the build status
[02:47:50.122] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:50.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:24:0) after 1m0s
[02:48:50.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:24:0)
[02:48:50.192] Timer tick, asking Buildbucket for the build status
[02:48:50.233] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:50.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:25:0) after 1m0s
[02:49:50.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:25:0)
[02:49:50.398] Timer tick, asking Buildbucket for the build status
[02:49:50.738] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:50.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:26:0) after 1m0s
[02:50:50.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:26:0)
[02:50:50.815] Timer tick, asking Buildbucket for the build status
[02:50:50.881] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:50.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:27:0) after 1m0s
[02:51:50.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:27:0)
[02:51:50.982] Timer tick, asking Buildbucket for the build status
[02:51:51.943] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:51.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:28:0) after 1m0s
[02:52:51.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:28:0)
[02:52:51.981] Timer tick, asking Buildbucket for the build status
[02:52:52.111] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:52.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:29:0) after 1m0s
[02:53:52.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:29:0)
[02:53:52.131] Timer tick, asking Buildbucket for the build status
[02:53:52.190] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:52.190] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:30:0) after 1m0s
[02:54:52.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:30:0)
[02:54:52.218] Timer tick, asking Buildbucket for the build status
[02:54:52.285] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:52.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:31:0) after 1m0s
[02:55:52.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:31:0)
[02:55:52.313] Timer tick, asking Buildbucket for the build status
[02:55:52.417] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:52.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:32:0) after 1m0s
[02:56:52.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:32:0)
[02:56:52.438] Timer tick, asking Buildbucket for the build status
[02:56:52.490] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:52.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:33:0) after 1m0s
[02:57:52.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:33:0)
[02:57:52.532] Timer tick, asking Buildbucket for the build status
[02:57:52.693] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:52.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:34:0) after 1m0s
[02:58:52.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:34:0)
[02:58:52.718] Timer tick, asking Buildbucket for the build status
[02:58:52.773] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:52.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:35:0) after 1m0s
[02:59:52.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:35:0)
[02:59:52.804] Timer tick, asking Buildbucket for the build status
[02:59:52.875] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:52.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:36:0) after 1m0s
[03:00:52.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:36:0)
[03:00:52.898] Timer tick, asking Buildbucket for the build status
[03:00:52.938] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:52.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:37:0) after 1m0s
[03:01:53.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:37:0)
[03:01:53.008] Timer tick, asking Buildbucket for the build status
[03:01:53.063] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:53.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:38:0) after 1m0s
[03:02:53.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:38:0)
[03:02:53.091] Timer tick, asking Buildbucket for the build status
[03:02:53.149] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:53.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:39:0) after 1m0s
[03:03:53.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:39:0)
[03:03:53.198] Timer tick, asking Buildbucket for the build status
[03:03:53.231] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:53.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:40:0) after 1m0s
[03:04:53.282] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:40:0)
[03:04:53.282] Timer tick, asking Buildbucket for the build status
[03:04:53.385] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:53.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:41:0) after 1m0s
[03:05:53.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:41:0)
[03:05:53.411] Timer tick, asking Buildbucket for the build status
[03:05:53.521] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:53.521] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:42:0) after 1m0s
[03:06:53.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:42:0)
[03:06:53.557] Timer tick, asking Buildbucket for the build status
[03:06:53.612] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:53.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:43:0) after 1m0s
[03:07:53.637] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:43:0)
[03:07:53.637] Timer tick, asking Buildbucket for the build status
[03:07:53.689] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:53.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:44:0) after 1m0s
[03:08:53.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:44:0)
[03:08:53.712] Timer tick, asking Buildbucket for the build status
[03:08:53.941] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:53.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:45:0) after 1m0s
[03:09:53.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:45:0)
[03:09:53.962] Timer tick, asking Buildbucket for the build status
[03:09:54.005] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:54.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:46:0) after 1m0s
[03:10:54.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:46:0)
[03:10:54.035] Timer tick, asking Buildbucket for the build status
[03:10:54.093] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:54.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:47:0) after 1m0s
[03:11:54.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:47:0)
[03:11:54.122] Timer tick, asking Buildbucket for the build status
[03:11:54.241] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:54.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:48:0) after 1m0s
[03:12:54.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:48:0)
[03:12:54.277] Timer tick, asking Buildbucket for the build status
[03:12:54.385] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:54.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:49:0) after 1m0s
[03:13:54.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:49:0)
[03:13:54.481] Timer tick, asking Buildbucket for the build status
[03:13:54.651] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:54.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:50:0) after 1m0s
[03:14:54.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:50:0)
[03:14:54.678] Timer tick, asking Buildbucket for the build status
[03:14:54.740] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:54.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:51:0) after 1m0s
[03:15:54.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:51:0)
[03:15:54.761] Timer tick, asking Buildbucket for the build status
[03:15:54.839] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:54.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:52:0) after 1m0s
[03:16:54.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:52:0)
[03:16:54.880] Timer tick, asking Buildbucket for the build status
[03:16:54.972] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:54.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:53:0) after 1m0s
[03:17:55.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:53:0)
[03:17:55.040] Timer tick, asking Buildbucket for the build status
[03:17:55.139] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:55.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:54:0) after 1m0s
[03:18:55.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:54:0)
[03:18:55.307] Timer tick, asking Buildbucket for the build status
[03:18:55.461] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:55.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:55:0) after 1m0s
[03:19:55.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:55:0)
[03:19:55.487] Timer tick, asking Buildbucket for the build status
[03:19:55.545] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:55.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:56:0) after 1m0s
[03:20:55.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:56:0)
[03:20:55.573] Timer tick, asking Buildbucket for the build status
[03:20:55.716] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:55.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:57:0) after 1m0s
[03:21:55.742] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:57:0)
[03:21:55.742] Timer tick, asking Buildbucket for the build status
[03:21:55.929] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:55.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:58:0) after 1m0s
[03:22:55.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:58:0)
[03:22:55.987] Timer tick, asking Buildbucket for the build status
[03:22:56.033] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:56.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:59:0) after 1m0s
[03:23:56.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:59:0)
[03:23:56.056] Timer tick, asking Buildbucket for the build status
[03:23:56.112] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:56.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:60:0) after 1m0s
[03:24:56.158] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:60:0)
[03:24:56.158] Timer tick, asking Buildbucket for the build status
[03:24:56.282] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:56.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:61:0) after 1m0s
[03:25:56.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:61:0)
[03:25:56.305] Timer tick, asking Buildbucket for the build status
[03:25:57.472] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:57.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:62:0) after 1m0s
[03:26:57.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:62:0)
[03:26:57.568] Timer tick, asking Buildbucket for the build status
[03:26:57.609] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:57.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:63:0) after 1m0s
[03:27:57.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:63:0)
[03:27:57.712] Timer tick, asking Buildbucket for the build status
[03:27:57.786] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:57.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:64:0) after 1m0s
[03:28:57.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:64:0)
[03:28:57.824] Timer tick, asking Buildbucket for the build status
[03:28:57.909] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:57.909] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:65:0) after 1m0s
[03:29:57.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:65:0)
[03:29:57.968] Timer tick, asking Buildbucket for the build status
[03:29:58.397] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:58.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:66:0) after 1m0s
[03:30:58.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:66:0)
[03:30:58.419] Timer tick, asking Buildbucket for the build status
[03:30:58.480] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:58.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:67:0) after 1m0s
[03:31:58.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:67:0)
[03:31:58.508] Timer tick, asking Buildbucket for the build status
[03:31:58.583] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:58.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:68:0) after 1m0s
[03:32:58.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:68:0)
[03:32:58.616] Timer tick, asking Buildbucket for the build status
[03:32:58.726] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:58.726] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:69:0) after 1m0s
[03:33:58.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:69:0)
[03:33:58.750] Timer tick, asking Buildbucket for the build status
[03:33:58.810] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:70:0) after 1m0s
[03:34:58.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:70:0)
[03:34:58.858] Timer tick, asking Buildbucket for the build status
[03:34:58.934] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:58.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:71:0) after 1m0s
[03:35:58.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:71:0)
[03:35:58.993] Timer tick, asking Buildbucket for the build status
[03:35:59.196] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:59.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:72:0) after 1m0s
[03:36:59.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:72:0)
[03:36:59.217] Timer tick, asking Buildbucket for the build status
[03:36:59.661] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:59.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:73:0) after 1m0s
[03:37:59.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:73:0)
[03:37:59.683] Timer tick, asking Buildbucket for the build status
[03:37:59.752] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:59.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:74:0) after 1m0s
[03:38:59.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:74:0)
[03:38:59.776] Timer tick, asking Buildbucket for the build status
[03:38:59.847] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:59.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:75:0) after 1m0s
[03:40:00.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:75:0)
[03:40:00.267] Timer tick, asking Buildbucket for the build status
[03:40:00.349] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:00.349] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:76:0) after 1m0s
[03:41:00.406] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:76:0)
[03:41:00.406] Timer tick, asking Buildbucket for the build status
[03:41:00.470] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:00.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:77:0) after 1m0s
[03:42:00.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:77:0)
[03:42:00.493] Timer tick, asking Buildbucket for the build status
[03:42:00.669] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:00.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:78:0) after 1m0s
[03:43:00.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:78:0)
[03:43:00.689] Timer tick, asking Buildbucket for the build status
[03:43:00.899] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:00.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:79:0) after 1m0s
[03:44:00.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:79:0)
[03:44:00.928] Timer tick, asking Buildbucket for the build status
[03:44:01.094] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:01.094] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:80:0) after 1m0s
[03:45:01.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:80:0)
[03:45:01.169] Timer tick, asking Buildbucket for the build status
[03:45:01.325] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:01.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:81:0) after 1m0s
[03:46:01.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:81:0)
[03:46:01.589] Timer tick, asking Buildbucket for the build status
[03:46:01.686] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:01.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:82:0) after 1m0s
[03:47:01.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:82:0)
[03:47:01.709] Timer tick, asking Buildbucket for the build status
[03:47:02.910] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:02.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:83:0) after 1m0s
[03:48:02.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:83:0)
[03:48:02.938] Timer tick, asking Buildbucket for the build status
[03:48:03.218] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:03.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:84:0) after 1m0s
[03:49:03.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:84:0)
[03:49:03.338] Timer tick, asking Buildbucket for the build status
[03:49:03.393] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:03.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:85:0) after 1m0s
[03:50:03.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:85:0)
[03:50:03.486] Timer tick, asking Buildbucket for the build status
[03:50:03.552] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:03.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:86:0) after 1m0s
[03:51:03.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:86:0)
[03:51:03.591] Timer tick, asking Buildbucket for the build status
[03:51:03.642] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:03.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:87:0) after 1m0s
[03:52:03.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:87:0)
[03:52:03.664] Timer tick, asking Buildbucket for the build status
[03:52:03.785] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:03.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:88:0) after 1m0s
[03:53:03.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:88:0)
[03:53:03.811] Timer tick, asking Buildbucket for the build status
[03:53:03.847] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:03.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:89:0) after 1m0s
[03:54:04.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:89:0)
[03:54:04.006] Timer tick, asking Buildbucket for the build status
[03:54:04.072] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:04.072] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:90:0) after 1m0s
[03:55:04.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:90:0)
[03:55:04.101] Timer tick, asking Buildbucket for the build status
[03:55:04.164] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:91:0) after 1m0s
[03:56:04.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:91:0)
[03:56:04.189] Timer tick, asking Buildbucket for the build status
[03:56:04.245] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:04.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:92:0) after 1m0s
[03:57:04.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:92:0)
[03:57:04.395] Timer tick, asking Buildbucket for the build status
[03:57:04.486] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:04.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:93:0) after 1m0s
[03:58:04.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:93:0)
[03:58:04.584] Timer tick, asking Buildbucket for the build status
[03:58:04.695] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:04.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:94:0) after 1m0s
[03:59:04.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:94:0)
[03:59:04.771] Timer tick, asking Buildbucket for the build status
[03:59:04.854] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:04.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:95:0) after 1m0s
[04:00:04.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:95:0)
[04:00:04.896] Timer tick, asking Buildbucket for the build status
[04:00:05.229] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:05.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:96:0) after 1m0s
[04:01:05.251] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:96:0)
[04:01:05.251] Timer tick, asking Buildbucket for the build status
[04:01:05.313] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:05.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:97:0) after 1m0s
[04:02:05.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:97:0)
[04:02:05.373] Timer tick, asking Buildbucket for the build status
[04:02:05.498] Build 8930281617231222960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:05.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9095711679342411264:98:0) after 1m0s
[04:02:25.106] Received PubSub notification, asking Buildbucket for the build status
[04:02:25.174] Build 8930281617231222960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:02:25.174] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1541822544186495",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541816805579380",
"id": "8930281617231222960",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Linux (dbg)\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3844-124e68f\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm627-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"2960ec33667a11bb4445dfe8154aef133c741afe\", \"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@{#607085}\", \"branch\": \"refs/heads/master\", \"revision\": \"81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Linux (dbg)\", \"got_webrtc_revision\": \"e769ed90c3599a131166d5a61625c1b64318fb91\", \"mastername\": \"chromium.linux\", \"got_angle_revision\": \"50bf0429394d3c1c191922cd45489db442785f75\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1541816805579380, \"tags\": [\"builder:Deterministic Linux (dbg)\", \"buildset:commit/git/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9095711679342411264\", \"scheduler_job_id:chromium/Deterministic Linux (dbg)\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8930281617231222960\"}}, \"got_v8_revision\": \"9d6971eb2913c552f9f43609683e273c0051c6fc\", \"got_v8_revision_cp\": \"refs/heads/7.2.293@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 3292, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"027b68e08c27d30823941c3a5f911c6adb4009b7\", \"gpu_perftests\": \"96d925cff1bd9c41ca2014e088bfb3a82295a1e3\", \"telemetry_unittests\": \"ac98a195452d638fe61cdcf45300f7c368790924\", \"load_library_perf_tests\": \"d079de1cf5d3e17ca5e25390ce9894ab1127215c\", \"devtools_closure_compile\": \"f34cd94e2af18153ed5740b13b878f2afa380b25\", \"chromedriver_py_tests\": \"9bd0c26a0f761117bdad5db9d5024a7025d432e8\", \"mojo_core_unittests\": \"037f58aa2ff9bd20e3ea99f17bf30da5ecfb1ae3\", \"leveldb_service_unittests\": \"830193da3a1a1d6b472bf0107e8c197f1bd1e106\", \"storage_unittests\": \"6313d4916a857cb7e9d7bbbccbc23882e01b1145\", \"jingle_unittests\": \"ad0d733b5a212761368a08dff12da00fa441136b\", \"angle_unittests\": \"9bf6bee650840ffed691138fe2064dd859777c33\", \"cast_unittests\": \"ca82ddc06c1c4846c40c0f4282a6cb907a05d6fd\", \"cc_unittests\": \"b514ba89e56a03c8e936e407b4018880c1d4c3d3\", \"blink_common_unittests\": \"01b9f2f864d271818f68bf47f705bbd9996c9bdc\", \"crashpad_tests\": \"eb825403ed2e15ea133fd6e2804c24134bd70948\", \"telemetry_perf_tests_without_chrome\": \"7ba28e1c7123cc97621ef0c248a331999adb53a8\", \"metrics_python_tests\": \"9907bb172b116c79bdae366b4c3f631973ec5e01\", \"message_center_unittests\": \"3d760d3a73f810d67ceb47e91cfd4ec3f47a9036\", \"ppapi_unittests\": \"e1fcd5a7ddfbf60708712f299e880ff02535ea51\", \"extensions_unittests\": \"ac41de2d1c1cc9c2724d4effa31b247d726617cd\", \"gl_unittests_ozone\": \"e9ed607c35e2f3b4fefe0cffcc821cd6cb320c64\", \"app_shell_unittests\": \"4a59077b0795d134fd77e72993c171d72ae41afd\", \"boringssl_ssl_tests\": \"fac477c82188bc1e057fd7ac8f2920cab9f2ea5a\", \"chrome_app_unittests\": \"576c573bd130da808538d08632a7098161df534d\", \"gl_unittests\": \"d2e5b6ee806996aa56056b2ff6441a43430ababd\", \"gcm_unit_tests\": \"e40aaf52fade60a573d6bbe861efbe51cff947b1\", \"views_unittests\": \"2120fa7b08165181f9a364ebac1252af7050d0d7\", \"content_shell_crash_test\": \"0628376a86ce03bca68fa72e58e561ffaa9268cb\", \"dawn_end2end_tests\": \"6a4037b0a1dcfaf2dc41f69d6a3d43fa2b42f537\", \"ui_base_unittests\": \"ba0ce34dade9cb792d2b167070fe17d7045a978a\", \"gles2_conform_test\": \"6d5cfb252acbea97e7e94e8b65f1fe2644080f0d\", \"cronet_unittests\": \"934d70beff7e708f61ac5d97cc9bde6a84539efa\", \"performance_test_suite\": \"593e95cb53ded1201a43ffc6f01cc646037251a2\", \"wm_unittests\": \"b512a0b05debb9d7e343686c14ce3506d1a22ade\", \"boringssl_crypto_tests\": \"d45c510910e0a24c711b99e9228714b847fbd574\", \"gin_unittests\": \"d8d2a5ae0d173f1f53abf5d47cef0a9b8fc8ce73\", \"performance_browser_tests\": \"f1972682f4e2d4860525954bb89aebb9cd6127c9\", \"extensions_browsertests\": \"1b2f33fe68e433a330e8075471221034b2b92477\", \"webkit_python_tests\": \"a5e7afa171bf1eca91b5486bd106259fa409df15\", \"headless_unittests\": \"f118bbedddbee89b91812c8ad81ee4ec7c904cfd\", \"webkit_layout_tests\": \"2f6227fe9c44fd11b26c4283f7142bd2a75ab46c\", \"breakpad_unittests\": \"2697e305259d742f30748b4e9efc24d7cc8d0364\", \"vr_pixeltests\": \"a03f51891bda3dc1a2aa818953ebd2271dbb019f\", \"webkit_unit_tests\": \"593905b9304b0a211e9905f1de0e1a6e55683781\", \"content_unittests\": \"849478763163e36fdc2e28bcb72c50931a161ef6\", \"performance_webview_test_suite\": \"d3191d21234cbac024d6ac7a7e261a2377971ff3\", \"wtf_unittests\": \"c6f054705c804077155c0de4af652825de15f7ad\", \"webkit_layout_tests_exparchive\": \"8531398e076673587447874ee937b743adbbccba\", \"traffic_annotation_auditor_unittests\": \"eb38d572caa3cfdfc9395c3428d60d2a2a679473\", \"libjingle_xmpp_unittests\": \"38abfe4b7ffe37e9c976e9d83efdc538057602d0\", \"remoting_unittests\": \"5b02c154233faf13a7907aea400b9b9e3a108871\", \"vr_common_perftests\": \"295905d964e9f084ba61d507ed58db1fad578cf1\", \"filesystem_service_unittests\": \"7f72078dd471b92c98c71bd188e3b73e48b48629\", \"gl_tests\": \"28370feb7d2f8baa88309d4f9550dab236fc6aed\", \"base_perftests\": \"2481c16e798d40d731d412d2394108a40b5b9bac\", \"headless_browsertests\": \"10a9c674bfb488d07affadab60b8444f5a9dd4cf\", \"capture_unittests\": \"5269fe38120bdee6df1a461688cf541d5f989ceb\", \"telemetry_gpu_unittests\": \"4338e996ccf3061f5a2b0d91123914e78cb47b14\", \"command_buffer_perftests\": \"b0630942a07485f885638d009b148050733b73bd\", \"media_unittests\": \"6df42cc75ee8572c2fe567e9a1530e5bc6df04c5\", \"gfx_unittests\": \"60b5c42e8e75fccdf1565d7c1abdf4fe122c4d2c\", \"chromedriver_unittests\": \"bc83ae4b665ebf120d4c4043810dbfd7ef370faa\", \"views_mus_interactive_ui_tests\": \"26df60c76adf855aa64366706f46e8c1a949ed32\", \"sandbox_linux_unittests\": \"1801da05a014d7d98553079292d1d2ae3424480d\", \"media_service_unittests\": \"5292338110fcce3f4fa54a5885b2048601c82745\", \"compositor_unittests\": \"9407440af58d8b0de7a9b3325df6e171cdf809b6\", \"latency_unittests\": \"5754cbfe1e32f5480f1ba6523c8f9426ceb8c8f4\", \"swiftshader_unittests\": \"210fbedff3904724c70c8033620e518e34e9f212\", \"telemetry_perf_unittests\": \"0277bc6a67fbf1e44d2d95ed140758b1f32c8de1\", \"media_blink_unittests\": \"a1bfe241eabf1b22da3f0a1b1cc19ec874dbed3e\", \"views_mus_unittests\": \"66fee12bbf1e757db4e9acc31129974b0da1ee21\", \"components_unittests\": \"0a5c3902b033b70e5785dd2acb8d801618f622e5\", \"snapshot_unittests\": \"46154eda36c4e227e08e568f018a48c3a1e6c5a7\", \"accessibility_unittests\": \"65063f63ee523225d6c4a3716895b5a86f39ead3\", \"net_perftests\": \"a77d92ebe12173e00ad1e12f22158ebecfb4ac76\", \"aura_unittests\": \"199f6bd0eafb654c0df122f82d6e047b4c4c34ab\", \"services_unittests\": \"4fb64097e25001cfae557da1758267b0da2d4b58\", \"components_perftests\": \"9bbc8fc41cb760926f1aee903ae5b549ec8b2a56\", \"events_unittests\": \"c0e7687a38f2e9dc7b55e2c22e571235a470a5f3\", \"tracing_perftests\": \"be1aae121a62a6db3563ae5a8479a2ec238f5793\", \"chromedriver_replay_unittests\": \"80dcdd65faa3e5c2519bd1b938064835370c9584\", \"ui_touch_selection_unittests\": \"9412c27cd75803adbd2156e75ae6039babbad735\", \"cacheinvalidation_unittests\": \"46c5c3ebcb2c6126aa675be40f5782d0f0154a69\", \"viz_unittests\": \"7a70779aa536d903a23fe25a06e7dd3c99647a1b\", \"browser_tests\": \"d7948a2ea06589e46bff3a35e3047874b30ae50d\", \"net_unittests\": \"00b6c4b215079713ed42beb26da17f81f2c9faac\", \"pdf_unittests\": \"9f99d1c042ce9f60375ff0ad86e0ea72dd79d88f\", \"dbus_unittests\": \"ba66659ababed4a1f59edbdbaa8191b64adad0f4\", \"vr_common_unittests\": \"28e62f17d899dc0ffed1970f04504e63f6eee81b\", \"gpu_unittests\": \"73c68e61e3f2578aeb398b43879a576d579c2aaa\", \"native_theme_unittests\": \"f0d5fb4120aa609b5b3e465e1bec9435cb67f9c3\", \"interactive_ui_tests\": \"8da8feb4c9da9804691c6002109825722d7a2929\", \"mojo_unittests\": \"c922a5f2a97f008b7b288d3c4c5a2544cac14b2f\", \"url_unittests\": \"d13c6bb082a51f3b96c1a1359aa94109f39ebda8\", \"media_perftests\": \"b75a6b0a0b627f6c8e708a4a558fdca7d8728cc8\", \"cronet_tests\": \"87ff442373dcbda85d3a9c1cfc79086b9747ab77\", \"google_apis_unittests\": \"85147a0148440b587b26917c020578fa2b1b5b6e\", \"telemetry_gpu_integration_test\": \"3bee5fc00377a2c5a7feebcbc5c30ceed36e7681\", \"blink_heap_unittests\": \"3d7cb517ade0a4df84b0e5abeb41352533b504d8\", \"midi_unittests\": \"6e9307ac8ec69b58de6bbc05862f15f726a934d3\", \"base_unittests\": \"656ca42ec92a4201935ce9fab403947cf6b465f8\", \"sync_integration_tests\": \"db07eb31b177ef889e08e2b07e98a0ab3141bc68\", \"sql_unittests\": \"2cf4c9379c0e67fb79c0cee45dcab19ca389d74d\", \"nacl_helper_nonsfi_unittests\": \"f9815984389dd3d7fefc63ed6f96699284294d98\", \"blink_fuzzer_unittests\": \"d1fa203a4e9167b50a9c603031d8051a583cbadb\", \"zucchini_unittests\": \"d01cd9d504ff496c7156847dbec162226fc957c4\", \"ipc_tests\": \"7d9f5c8abb81d18e3b10789ab3509e251f7e2f9c\", \"courgette_unittests\": \"66cd254294e692c1005ffcaccecfd6219519b9df\", \"devtools_eslint\": \"0a7533a321abb89e37a5122f9ce2b08242be7799\", \"blink_platform_unittests\": \"38e7f74fe383a202fd494de239e4ab08d6ed6f69\", \"components_browsertests\": \"3ee42bb9087265d2c012911dbd2e7f9e54b0aefa\", \"views_perftests\": \"31c7e233d7062e4f4da5d61f92dfdf9da7a5e967\", \"angle_perftests\": \"a92362b2e24a33dbb438c8d97780ecdf0a3ecbbc\", \"display_unittests\": \"74557246940d3bc0a71aacff4be1d05ba0dd0869\", \"service_manager_unittests\": \"a37f017e9509e983e11bb399615b1e0cc19635d3\", \"angle_end2end_tests\": \"1895b88354557dd3fe8f361ada98c7370d8246c8\", \"skia_unittests\": \"3cdf72bf9cccbe77513d4e8a9a2a608996804117\", \"angle_white_box_tests\": \"958a13547da50421ac4b8bed813a8dc366e5bc72\", \"crypto_unittests\": \"f66ecabd79abdb85c9577fad6e161ae00a144e2c\", \"nacl_loader_unittests\": \"9bf51df7d7d0bc7035c3c63caa9dafbb20bcfd3b\", \"unit_tests\": \"a4acec7bf3d00b5fa36aee1f55e8bcf9ceaae640\", \"content_browsertests\": \"d097c2e638996cc44884e1eea28ab8b481bd9423\", \"printing_unittests\": \"d7de8d77ee11648f8c2ad9a3253df9f75b5a4b69\", \"device_unittests\": \"ddf1a3847b557ca8d27c06d9c5d566e7ce6964e0\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm627-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1541816846108150",
"status": "COMPLETED",
"status_changed_ts": "1541822544701474",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/3292",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095711679342411264",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_dimension:builder:Deterministic Linux (dbg)",
"swarming_dimension:caches:builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_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 (dbg)/3292",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8930281617231222960",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c8ae520b7ed0f3687d2af0e926104b1bcbf0f37",
"swarming_tag:builder:Deterministic Linux (dbg)",
"swarming_tag:buildset:commit/git/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81dfa8e54a460006adeb46cdcdd18f15dc2b6cc3",
"swarming_tag:caches:builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_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/8930281617231222960/+/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:9095711679342411264",
"swarming_tag:scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:43eed580a711b6fa3c17ee91a8c14ff22cb7390f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:411442f5527a0d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1541822544703319",
"url": "https://ci.chromium.org/b/8930281617231222960",
"utcnow_ts": "1541822545158493"
}
}
[04:02:25.174] Invocation finished in 1h35m40.992017147s with status SUCCEEDED