[21:03:08.275] New invocation is queued and will start shortly
[21:03:09.609] Starting the invocation (attempt 1)
[21:03:09.638] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:03:09.638] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:03:09.638] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9098087559543178608",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"98cc77946ed5ceb4cbda3b0087dfda100b0d4c35\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9098087559543178608",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"gitiles_ref:refs/heads/master"
]
}
[21:03:11.543] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539550989802050",
"id": "8932657497275587360",
"lease_expiration_ts": "1539669791087946",
"lease_key": "1853436946",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"98cc77946ed5ceb4cbda3b0087dfda100b0d4c35\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1539550991409341",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/17174",
"builder:Deterministic Linux",
"buildset:commit/git/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098087559543178608",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_dimension:builder:Deterministic Linux",
"swarming_dimension:caches:builder_26450780b77752b73235b8dcd76e4371340e7d14b7166082470bfa623c3e2d62_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/17174",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932657497275587360",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Deterministic Linux",
"swarming_tag:buildset:commit/git/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"swarming_tag:caches:builder_26450780b77752b73235b8dcd76e4371340e7d14b7166082470bfa623c3e2d62_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/8932657497275587360/+/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:9098087559543178608",
"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:9d4e55f09f057cb6c6ed423e82fe5a8bae98ab2b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:408d3559acff0a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1539550991409420",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Linux/17174",
"utcnow_ts": "1539550991529208"
}
}
[21:03:11.543] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Linux/17174
[21:03:11.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:2:0) after 1m0s
[21:03:14.567] Received PubSub notification, asking Buildbucket for the build status
[21:03:14.611] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:2:0)
[21:04:11.697] Timer tick, asking Buildbucket for the build status
[21:04:11.741] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:4:0) after 1m0s
[21:05:12.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:4:0)
[21:05:12.037] Timer tick, asking Buildbucket for the build status
[21:05:12.123] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:12.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:5:0) after 1m0s
[21:06:12.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:5:0)
[21:06:12.250] Timer tick, asking Buildbucket for the build status
[21:06:12.349] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:12.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:6:0) after 1m0s
[21:07:12.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:6:0)
[21:07:12.563] Timer tick, asking Buildbucket for the build status
[21:07:12.726] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:12.726] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:7:0) after 1m0s
[21:08:12.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:7:0)
[21:08:12.925] Timer tick, asking Buildbucket for the build status
[21:08:12.984] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:8:0) after 1m0s
[21:09:13.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:8:0)
[21:09:13.222] Timer tick, asking Buildbucket for the build status
[21:09:13.260] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:13.260] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:9:0) after 1m0s
[21:10:13.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:9:0)
[21:10:13.614] Timer tick, asking Buildbucket for the build status
[21:10:13.677] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:13.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:10:0) after 1m0s
[21:11:13.935] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:10:0)
[21:11:13.935] Timer tick, asking Buildbucket for the build status
[21:11:14.001] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:14.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:11:0) after 1m0s
[21:12:14.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:11:0)
[21:12:14.614] Timer tick, asking Buildbucket for the build status
[21:12:14.817] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:14.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:12:0) after 1m0s
[21:13:15.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:12:0)
[21:13:15.154] Timer tick, asking Buildbucket for the build status
[21:13:15.200] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:15.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:13:0) after 1m0s
[21:14:15.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:13:0)
[21:14:15.252] Timer tick, asking Buildbucket for the build status
[21:14:15.317] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:15.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:14:0) after 1m0s
[21:15:15.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:14:0)
[21:15:15.336] Timer tick, asking Buildbucket for the build status
[21:15:15.417] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:15.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:15:0) after 1m0s
[21:16:15.447] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:15:0)
[21:16:15.447] Timer tick, asking Buildbucket for the build status
[21:16:15.749] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:15.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:16:0) after 1m0s
[21:17:15.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:16:0)
[21:17:15.769] Timer tick, asking Buildbucket for the build status
[21:17:16.024] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:16.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:17:0) after 1m0s
[21:18:16.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:17:0)
[21:18:16.073] Timer tick, asking Buildbucket for the build status
[21:18:16.130] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:16.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:18:0) after 1m0s
[21:19:16.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:18:0)
[21:19:16.184] Timer tick, asking Buildbucket for the build status
[21:19:16.302] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:16.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:19:0) after 1m0s
[21:20:16.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:19:0)
[21:20:16.336] Timer tick, asking Buildbucket for the build status
[21:20:16.502] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:16.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:20:0) after 1m0s
[21:21:16.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:20:0)
[21:21:16.524] Timer tick, asking Buildbucket for the build status
[21:21:16.712] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:16.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:21:0) after 1m0s
[21:22:16.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:21:0)
[21:22:16.730] Timer tick, asking Buildbucket for the build status
[21:22:16.773] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:16.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:22:0) after 1m0s
[21:23:16.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:22:0)
[21:23:16.791] Timer tick, asking Buildbucket for the build status
[21:23:16.851] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:16.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:23:0) after 1m0s
[21:24:16.949] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:23:0)
[21:24:16.949] Timer tick, asking Buildbucket for the build status
[21:24:17.097] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:17.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:24:0) after 1m0s
[21:25:17.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:24:0)
[21:25:17.404] Timer tick, asking Buildbucket for the build status
[21:25:17.441] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:17.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:25:0) after 1m0s
[21:26:17.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:25:0)
[21:26:17.728] Timer tick, asking Buildbucket for the build status
[21:26:17.794] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:17.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:26:0) after 1m0s
[21:27:17.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:26:0)
[21:27:17.988] Timer tick, asking Buildbucket for the build status
[21:27:18.043] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:18.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:27:0) after 1m0s
[21:28:18.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:27:0)
[21:28:18.343] Timer tick, asking Buildbucket for the build status
[21:28:18.432] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:18.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:28:0) after 1m0s
[21:29:18.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:28:0)
[21:29:18.717] Timer tick, asking Buildbucket for the build status
[21:29:18.785] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:18.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:29:0) after 1m0s
[21:30:19.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:29:0)
[21:30:19.113] Timer tick, asking Buildbucket for the build status
[21:30:19.180] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:19.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:30:0) after 1m0s
[21:31:19.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:30:0)
[21:31:19.438] Timer tick, asking Buildbucket for the build status
[21:31:19.476] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:19.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:31:0) after 1m0s
[21:32:19.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:31:0)
[21:32:19.818] Timer tick, asking Buildbucket for the build status
[21:32:19.929] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:19.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:32:0) after 1m0s
[21:33:20.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:32:0)
[21:33:20.153] Timer tick, asking Buildbucket for the build status
[21:33:20.221] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:20.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:33:0) after 1m0s
[21:34:20.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:33:0)
[21:34:20.464] Timer tick, asking Buildbucket for the build status
[21:34:20.571] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:20.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:34:0) after 1m0s
[21:35:20.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:34:0)
[21:35:20.706] Timer tick, asking Buildbucket for the build status
[21:35:20.777] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:20.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:35:0) after 1m0s
[21:36:21.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:35:0)
[21:36:21.057] Timer tick, asking Buildbucket for the build status
[21:36:21.211] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:21.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:36:0) after 1m0s
[21:37:21.357] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:36:0)
[21:37:21.357] Timer tick, asking Buildbucket for the build status
[21:37:21.469] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:21.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:37:0) after 1m0s
[21:38:21.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:37:0)
[21:38:21.496] Timer tick, asking Buildbucket for the build status
[21:38:21.555] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:21.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:38:0) after 1m0s
[21:39:21.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:38:0)
[21:39:21.934] Timer tick, asking Buildbucket for the build status
[21:39:22.011] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:22.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:39:0) after 1m0s
[21:40:22.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:39:0)
[21:40:22.044] Timer tick, asking Buildbucket for the build status
[21:40:22.137] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:22.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:40:0) after 1m0s
[21:41:22.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:40:0)
[21:41:22.232] Timer tick, asking Buildbucket for the build status
[21:41:22.346] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:22.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:41:0) after 1m0s
[21:42:22.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:41:0)
[21:42:22.563] Timer tick, asking Buildbucket for the build status
[21:42:22.661] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:22.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:42:0) after 1m0s
[21:43:22.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:42:0)
[21:43:22.995] Timer tick, asking Buildbucket for the build status
[21:43:23.067] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:23.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:43:0) after 1m0s
[21:44:23.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:43:0)
[21:44:23.390] Timer tick, asking Buildbucket for the build status
[21:44:23.454] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:23.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:44:0) after 1m0s
[21:45:23.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:44:0)
[21:45:23.767] Timer tick, asking Buildbucket for the build status
[21:45:23.873] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:23.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:45:0) after 1m0s
[21:46:24.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:45:0)
[21:46:24.234] Timer tick, asking Buildbucket for the build status
[21:46:24.306] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:24.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:46:0) after 1m0s
[21:47:24.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:46:0)
[21:47:24.641] Timer tick, asking Buildbucket for the build status
[21:47:24.768] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:24.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:47:0) after 1m0s
[21:48:25.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:47:0)
[21:48:25.032] Timer tick, asking Buildbucket for the build status
[21:48:25.125] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:25.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:48:0) after 1m0s
[21:49:25.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:48:0)
[21:49:25.356] Timer tick, asking Buildbucket for the build status
[21:49:25.417] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:25.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:49:0) after 1m0s
[21:50:25.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:49:0)
[21:50:25.678] Timer tick, asking Buildbucket for the build status
[21:50:26.020] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:26.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:50:0) after 1m0s
[21:51:26.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:50:0)
[21:51:26.193] Timer tick, asking Buildbucket for the build status
[21:51:26.256] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:26.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:51:0) after 1m0s
[21:52:26.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:51:0)
[21:52:26.464] Timer tick, asking Buildbucket for the build status
[21:52:26.563] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:26.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:52:0) after 1m0s
[21:53:26.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:52:0)
[21:53:26.824] Timer tick, asking Buildbucket for the build status
[21:53:26.878] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:26.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:53:0) after 1m0s
[21:54:26.900] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:53:0)
[21:54:26.900] Timer tick, asking Buildbucket for the build status
[21:54:26.974] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:26.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:54:0) after 1m0s
[21:55:27.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:54:0)
[21:55:27.017] Timer tick, asking Buildbucket for the build status
[21:55:27.137] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:27.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:55:0) after 1m0s
[21:56:27.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:55:0)
[21:56:27.165] Timer tick, asking Buildbucket for the build status
[21:56:27.371] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:27.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:56:0) after 1m0s
[21:57:27.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:56:0)
[21:57:27.390] Timer tick, asking Buildbucket for the build status
[21:57:27.474] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:27.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:57:0) after 1m0s
[21:58:27.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:57:0)
[21:58:27.500] Timer tick, asking Buildbucket for the build status
[21:58:27.567] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:27.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:58:0) after 1m0s
[21:59:27.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:58:0)
[21:59:27.591] Timer tick, asking Buildbucket for the build status
[21:59:27.747] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:27.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:59:0) after 1m0s
[22:00:27.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:59:0)
[22:00:27.766] Timer tick, asking Buildbucket for the build status
[22:00:27.832] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:27.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:60:0) after 1m0s
[22:01:27.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:60:0)
[22:01:27.901] Timer tick, asking Buildbucket for the build status
[22:01:27.963] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:27.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:61:0) after 1m0s
[22:02:27.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:61:0)
[22:02:27.984] Timer tick, asking Buildbucket for the build status
[22:02:28.139] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:28.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:62:0) after 1m0s
[22:03:28.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:62:0)
[22:03:28.306] Timer tick, asking Buildbucket for the build status
[22:03:28.407] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:28.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:63:0) after 1m0s
[22:04:28.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:63:0)
[22:04:28.645] Timer tick, asking Buildbucket for the build status
[22:04:28.747] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:28.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:64:0) after 1m0s
[22:05:28.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:64:0)
[22:05:28.772] Timer tick, asking Buildbucket for the build status
[22:05:28.969] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:28.969] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:65:0) after 1m0s
[22:06:28.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:65:0)
[22:06:28.999] Timer tick, asking Buildbucket for the build status
[22:06:29.057] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:29.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:66:0) after 1m0s
[22:07:29.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:66:0)
[22:07:29.078] Timer tick, asking Buildbucket for the build status
[22:07:29.135] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:29.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:67:0) after 1m0s
[22:08:29.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:67:0)
[22:08:29.157] Timer tick, asking Buildbucket for the build status
[22:08:29.263] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:29.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:68:0) after 1m0s
[22:09:29.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:68:0)
[22:09:29.344] Timer tick, asking Buildbucket for the build status
[22:09:29.499] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:29.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:69:0) after 1m0s
[22:10:29.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:69:0)
[22:10:29.528] Timer tick, asking Buildbucket for the build status
[22:10:29.580] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:29.580] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:70:0) after 1m0s
[22:11:29.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:70:0)
[22:11:29.631] Timer tick, asking Buildbucket for the build status
[22:11:29.761] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:29.761] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:71:0) after 1m0s
[22:12:29.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:71:0)
[22:12:29.782] Timer tick, asking Buildbucket for the build status
[22:12:29.825] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:29.825] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:72:0) after 1m0s
[22:13:29.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:72:0)
[22:13:29.844] Timer tick, asking Buildbucket for the build status
[22:13:29.887] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:29.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:73:0) after 1m0s
[22:14:30.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:73:0)
[22:14:30.248] Timer tick, asking Buildbucket for the build status
[22:14:30.341] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:30.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:74:0) after 1m0s
[22:15:30.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:74:0)
[22:15:30.427] Timer tick, asking Buildbucket for the build status
[22:15:30.497] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:30.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:75:0) after 1m0s
[22:16:30.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:75:0)
[22:16:30.538] Timer tick, asking Buildbucket for the build status
[22:16:30.587] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:30.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:76:0) after 1m0s
[22:17:30.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:76:0)
[22:17:30.617] Timer tick, asking Buildbucket for the build status
[22:17:30.716] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:30.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:77:0) after 1m0s
[22:18:30.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:77:0)
[22:18:30.734] Timer tick, asking Buildbucket for the build status
[22:18:30.828] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:30.828] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:78:0) after 1m0s
[22:19:30.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:78:0)
[22:19:30.852] Timer tick, asking Buildbucket for the build status
[22:19:31.048] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:31.048] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:79:0) after 1m0s
[22:20:31.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:79:0)
[22:20:31.071] Timer tick, asking Buildbucket for the build status
[22:20:31.207] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:31.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:80:0) after 1m0s
[22:21:31.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:80:0)
[22:21:31.243] Timer tick, asking Buildbucket for the build status
[22:21:31.413] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:31.413] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:81:0) after 1m0s
[22:22:31.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:81:0)
[22:22:31.452] Timer tick, asking Buildbucket for the build status
[22:22:31.631] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:31.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:82:0) after 1m0s
[22:23:31.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:82:0)
[22:23:31.651] Timer tick, asking Buildbucket for the build status
[22:23:31.708] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:31.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:83:0) after 1m0s
[22:24:31.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:83:0)
[22:24:31.731] Timer tick, asking Buildbucket for the build status
[22:24:31.835] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:31.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:84:0) after 1m0s
[22:25:31.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:84:0)
[22:25:31.871] Timer tick, asking Buildbucket for the build status
[22:25:31.948] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:31.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:85:0) after 1m0s
[22:26:31.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:85:0)
[22:26:31.997] Timer tick, asking Buildbucket for the build status
[22:26:32.035] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:32.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:86:0) after 1m0s
[22:27:32.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:86:0)
[22:27:32.065] Timer tick, asking Buildbucket for the build status
[22:27:32.211] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:32.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:87:0) after 1m0s
[22:28:32.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:87:0)
[22:28:32.233] Timer tick, asking Buildbucket for the build status
[22:28:32.424] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:32.424] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:88:0) after 1m0s
[22:29:32.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:88:0)
[22:29:32.488] Timer tick, asking Buildbucket for the build status
[22:29:32.548] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:32.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:89:0) after 1m0s
[22:30:32.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:89:0)
[22:30:32.568] Timer tick, asking Buildbucket for the build status
[22:30:32.647] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:32.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:90:0) after 1m0s
[22:31:32.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:90:0)
[22:31:32.667] Timer tick, asking Buildbucket for the build status
[22:31:32.735] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:91:0) after 1m0s
[22:32:32.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:91:0)
[22:32:32.759] Timer tick, asking Buildbucket for the build status
[22:32:32.910] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:32.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:92:0) after 1m0s
[22:33:32.938] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:92:0)
[22:33:32.938] Timer tick, asking Buildbucket for the build status
[22:33:33.051] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:33.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:93:0) after 1m0s
[22:34:33.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:93:0)
[22:34:33.070] Timer tick, asking Buildbucket for the build status
[22:34:33.231] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:33.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:94:0) after 1m0s
[22:35:33.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:94:0)
[22:35:33.252] Timer tick, asking Buildbucket for the build status
[22:35:33.316] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:33.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:95:0) after 1m0s
[22:36:33.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:95:0)
[22:36:33.340] Timer tick, asking Buildbucket for the build status
[22:36:33.436] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:33.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:96:0) after 1m0s
[22:37:33.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:96:0)
[22:37:33.457] Timer tick, asking Buildbucket for the build status
[22:37:33.587] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:33.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:97:0) after 1m0s
[22:38:33.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:97:0)
[22:38:33.607] Timer tick, asking Buildbucket for the build status
[22:38:33.783] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:33.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:98:0) after 1m0s
[22:39:33.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:98:0)
[22:39:33.808] Timer tick, asking Buildbucket for the build status
[22:39:33.864] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:33.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:99:0) after 1m0s
[22:40:33.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:99:0)
[22:40:33.888] Timer tick, asking Buildbucket for the build status
[22:40:33.952] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:33.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:100:0) after 1m0s
[22:41:34.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:100:0)
[22:41:34.007] Timer tick, asking Buildbucket for the build status
[22:41:34.096] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:34.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:101:0) after 1m0s
[22:42:34.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:101:0)
[22:42:34.117] Timer tick, asking Buildbucket for the build status
[22:42:34.199] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:34.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:102:0) after 1m0s
[22:43:34.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:102:0)
[22:43:34.228] Timer tick, asking Buildbucket for the build status
[22:43:34.277] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:34.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:103:0) after 1m0s
[22:44:34.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:103:0)
[22:44:34.298] Timer tick, asking Buildbucket for the build status
[22:44:34.367] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:104:0) after 1m0s
[22:45:34.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:104:0)
[22:45:34.401] Timer tick, asking Buildbucket for the build status
[22:45:34.513] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:34.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:105:0) after 1m0s
[22:46:34.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:105:0)
[22:46:34.536] Timer tick, asking Buildbucket for the build status
[22:46:34.573] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:34.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:106:0) after 1m0s
[22:47:34.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:106:0)
[22:47:34.603] Timer tick, asking Buildbucket for the build status
[22:47:34.648] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:34.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:107:0) after 1m0s
[22:48:34.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:107:0)
[22:48:34.677] Timer tick, asking Buildbucket for the build status
[22:48:34.750] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:34.750] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:108:0) after 1m0s
[22:49:34.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:108:0)
[22:49:34.771] Timer tick, asking Buildbucket for the build status
[22:49:34.981] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:34.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:109:0) after 1m0s
[22:50:35.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:109:0)
[22:50:35.005] Timer tick, asking Buildbucket for the build status
[22:50:35.133] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:35.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:110:0) after 1m0s
[22:51:35.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:110:0)
[22:51:35.166] Timer tick, asking Buildbucket for the build status
[22:51:35.222] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:35.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:111:0) after 1m0s
[22:52:35.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:111:0)
[22:52:35.244] Timer tick, asking Buildbucket for the build status
[22:52:35.331] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:35.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:112:0) after 1m0s
[22:53:35.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:112:0)
[22:53:35.421] Timer tick, asking Buildbucket for the build status
[22:53:35.496] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:35.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:113:0) after 1m0s
[22:54:35.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:113:0)
[22:54:35.716] Timer tick, asking Buildbucket for the build status
[22:54:35.780] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:35.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:114:0) after 1m0s
[22:55:35.803] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:114:0)
[22:55:35.803] Timer tick, asking Buildbucket for the build status
[22:55:35.882] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:35.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:115:0) after 1m0s
[22:56:35.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:115:0)
[22:56:35.915] Timer tick, asking Buildbucket for the build status
[22:56:36.017] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:36.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:116:0) after 1m0s
[22:57:36.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:116:0)
[22:57:36.066] Timer tick, asking Buildbucket for the build status
[22:57:36.131] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:36.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:117:0) after 1m0s
[22:58:36.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:117:0)
[22:58:36.169] Timer tick, asking Buildbucket for the build status
[22:58:36.327] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:36.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:118:0) after 1m0s
[22:59:36.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:118:0)
[22:59:36.351] Timer tick, asking Buildbucket for the build status
[22:59:36.437] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:36.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:119:0) after 1m0s
[23:00:36.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:119:0)
[23:00:36.463] Timer tick, asking Buildbucket for the build status
[23:00:36.579] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:36.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:120:0) after 1m0s
[23:01:36.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:120:0)
[23:01:36.602] Timer tick, asking Buildbucket for the build status
[23:01:36.696] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:36.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:121:0) after 1m0s
[23:02:36.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:121:0)
[23:02:36.748] Timer tick, asking Buildbucket for the build status
[23:02:36.871] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:36.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:122:0) after 1m0s
[23:03:36.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:122:0)
[23:03:36.894] Timer tick, asking Buildbucket for the build status
[23:03:37.009] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:37.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:123:0) after 1m0s
[23:04:37.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:123:0)
[23:04:37.118] Timer tick, asking Buildbucket for the build status
[23:04:37.197] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:37.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:124:0) after 1m0s
[23:05:37.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:124:0)
[23:05:37.229] Timer tick, asking Buildbucket for the build status
[23:05:37.300] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:37.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:125:0) after 1m0s
[23:06:37.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:125:0)
[23:06:37.322] Timer tick, asking Buildbucket for the build status
[23:06:37.379] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:37.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:126:0) after 1m0s
[23:07:37.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:126:0)
[23:07:37.407] Timer tick, asking Buildbucket for the build status
[23:07:37.628] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:37.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:127:0) after 1m0s
[23:08:37.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:127:0)
[23:08:37.651] Timer tick, asking Buildbucket for the build status
[23:08:37.963] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:37.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:128:0) after 1m0s
[23:09:38.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:128:0)
[23:09:38.056] Timer tick, asking Buildbucket for the build status
[23:09:38.116] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:38.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:129:0) after 1m0s
[23:10:38.245] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:129:0)
[23:10:38.245] Timer tick, asking Buildbucket for the build status
[23:10:38.346] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:38.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:130:0) after 1m0s
[23:11:38.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:130:0)
[23:11:38.497] Timer tick, asking Buildbucket for the build status
[23:11:38.657] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:38.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:131:0) after 1m0s
[23:12:38.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:131:0)
[23:12:38.683] Timer tick, asking Buildbucket for the build status
[23:12:38.801] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:38.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:132:0) after 1m0s
[23:13:38.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:132:0)
[23:13:38.826] Timer tick, asking Buildbucket for the build status
[23:13:38.958] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:38.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:133:0) after 1m0s
[23:14:38.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:133:0)
[23:14:38.982] Timer tick, asking Buildbucket for the build status
[23:14:39.045] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:39.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:134:0) after 1m0s
[23:15:39.068] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:134:0)
[23:15:39.069] Timer tick, asking Buildbucket for the build status
[23:15:39.146] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:39.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:135:0) after 1m0s
[23:16:39.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:135:0)
[23:16:39.171] Timer tick, asking Buildbucket for the build status
[23:16:39.233] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:39.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:136:0) after 1m0s
[23:17:39.258] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:136:0)
[23:17:39.258] Timer tick, asking Buildbucket for the build status
[23:17:39.322] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:39.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:137:0) after 1m0s
[23:18:39.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:137:0)
[23:18:39.354] Timer tick, asking Buildbucket for the build status
[23:18:39.540] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:39.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:138:0) after 1m0s
[23:19:39.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:138:0)
[23:19:39.566] Timer tick, asking Buildbucket for the build status
[23:19:39.637] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:39.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:139:0) after 1m0s
[23:20:39.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:139:0)
[23:20:39.801] Timer tick, asking Buildbucket for the build status
[23:20:39.861] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:39.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:140:0) after 1m0s
[23:21:39.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:140:0)
[23:21:39.882] Timer tick, asking Buildbucket for the build status
[23:21:40.065] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:40.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:141:0) after 1m0s
[23:22:40.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:141:0)
[23:22:40.096] Timer tick, asking Buildbucket for the build status
[23:22:40.241] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:40.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:142:0) after 1m0s
[23:23:40.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:142:0)
[23:23:40.265] Timer tick, asking Buildbucket for the build status
[23:23:40.337] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:40.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:143:0) after 1m0s
[23:24:40.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:143:0)
[23:24:40.368] Timer tick, asking Buildbucket for the build status
[23:24:40.442] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:40.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:144:0) after 1m0s
[23:25:40.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:144:0)
[23:25:40.897] Timer tick, asking Buildbucket for the build status
[23:25:40.983] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:40.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:145:0) after 1m0s
[23:26:41.072] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:145:0)
[23:26:41.072] Timer tick, asking Buildbucket for the build status
[23:26:41.144] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:41.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:146:0) after 1m0s
[23:27:41.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:146:0)
[23:27:41.281] Timer tick, asking Buildbucket for the build status
[23:27:41.406] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:41.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:147:0) after 1m0s
[23:28:41.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:147:0)
[23:28:41.496] Timer tick, asking Buildbucket for the build status
[23:28:41.571] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:41.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:148:0) after 1m0s
[23:29:41.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:148:0)
[23:29:41.595] Timer tick, asking Buildbucket for the build status
[23:29:41.665] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:41.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:149:0) after 1m0s
[23:30:41.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:149:0)
[23:30:41.777] Timer tick, asking Buildbucket for the build status
[23:30:42.012] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:42.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:150:0) after 1m0s
[23:31:42.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:150:0)
[23:31:42.036] Timer tick, asking Buildbucket for the build status
[23:31:42.098] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:42.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:151:0) after 1m0s
[23:32:42.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:151:0)
[23:32:42.118] Timer tick, asking Buildbucket for the build status
[23:32:42.275] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:42.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:152:0) after 1m0s
[23:33:42.323] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:152:0)
[23:33:42.323] Timer tick, asking Buildbucket for the build status
[23:33:42.399] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:42.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:153:0) after 1m0s
[23:34:42.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:153:0)
[23:34:42.420] Timer tick, asking Buildbucket for the build status
[23:34:42.482] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:42.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:154:0) after 1m0s
[23:35:42.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:154:0)
[23:35:42.603] Timer tick, asking Buildbucket for the build status
[23:35:42.643] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:42.644] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:155:0) after 1m0s
[23:36:42.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:155:0)
[23:36:42.776] Timer tick, asking Buildbucket for the build status
[23:36:42.838] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:42.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:156:0) after 1m0s
[23:37:42.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:156:0)
[23:37:42.907] Timer tick, asking Buildbucket for the build status
[23:37:42.959] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:42.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:157:0) after 1m0s
[23:38:42.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:157:0)
[23:38:42.999] Timer tick, asking Buildbucket for the build status
[23:38:43.074] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:43.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:158:0) after 1m0s
[23:39:43.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:158:0)
[23:39:43.103] Timer tick, asking Buildbucket for the build status
[23:39:43.206] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:43.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:159:0) after 1m0s
[23:40:43.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:159:0)
[23:40:43.240] Timer tick, asking Buildbucket for the build status
[23:40:43.389] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:43.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:160:0) after 1m0s
[23:41:43.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:160:0)
[23:41:43.412] Timer tick, asking Buildbucket for the build status
[23:41:43.507] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:43.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:161:0) after 1m0s
[23:42:43.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:161:0)
[23:42:43.542] Timer tick, asking Buildbucket for the build status
[23:42:43.612] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:43.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:162:0) after 1m0s
[23:43:43.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:162:0)
[23:43:43.641] Timer tick, asking Buildbucket for the build status
[23:43:43.806] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:43.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:163:0) after 1m0s
[23:44:43.900] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:163:0)
[23:44:43.900] Timer tick, asking Buildbucket for the build status
[23:44:44.042] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:44.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:164:0) after 1m0s
[23:45:44.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:164:0)
[23:45:44.071] Timer tick, asking Buildbucket for the build status
[23:45:44.252] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:44.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:165:0) after 1m0s
[23:46:44.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:165:0)
[23:46:44.281] Timer tick, asking Buildbucket for the build status
[23:46:44.339] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:44.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:166:0) after 1m0s
[23:47:44.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:166:0)
[23:47:44.370] Timer tick, asking Buildbucket for the build status
[23:47:44.503] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:44.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:167:0) after 1m0s
[23:48:44.536] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:167:0)
[23:48:44.536] Timer tick, asking Buildbucket for the build status
[23:48:44.758] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:44.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:168:0) after 1m0s
[23:49:44.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:168:0)
[23:49:44.786] Timer tick, asking Buildbucket for the build status
[23:49:44.847] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:44.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:169:0) after 1m0s
[23:50:44.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:169:0)
[23:50:44.939] Timer tick, asking Buildbucket for the build status
[23:50:45.065] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:45.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:170:0) after 1m0s
[23:51:45.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:170:0)
[23:51:45.118] Timer tick, asking Buildbucket for the build status
[23:51:45.279] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:45.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:171:0) after 1m0s
[23:52:45.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:171:0)
[23:52:45.313] Timer tick, asking Buildbucket for the build status
[23:52:45.490] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:45.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:172:0) after 1m0s
[23:53:45.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:172:0)
[23:53:45.514] Timer tick, asking Buildbucket for the build status
[23:53:45.672] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:173:0) after 1m0s
[23:54:45.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:173:0)
[23:54:45.706] Timer tick, asking Buildbucket for the build status
[23:54:45.808] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:45.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:174:0) after 1m0s
[23:55:45.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:174:0)
[23:55:45.831] Timer tick, asking Buildbucket for the build status
[23:55:45.932] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:45.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:175:0) after 1m0s
[23:56:45.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:175:0)
[23:56:45.955] Timer tick, asking Buildbucket for the build status
[23:56:46.099] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:46.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:176:0) after 1m0s
[23:57:46.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:176:0)
[23:57:46.152] Timer tick, asking Buildbucket for the build status
[23:57:46.246] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:46.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:177:0) after 1m0s
[23:58:46.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:177:0)
[23:58:46.267] Timer tick, asking Buildbucket for the build status
[23:58:46.303] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:46.303] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:178:0) after 1m0s
[23:59:46.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:178:0)
[23:59:46.552] Timer tick, asking Buildbucket for the build status
[23:59:46.642] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:179:0) after 1m0s
[00:00:46.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:179:0)
[00:00:46.671] Timer tick, asking Buildbucket for the build status
[00:00:46.745] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:46.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:180:0) after 1m0s
[00:01:46.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:180:0)
[00:01:46.837] Timer tick, asking Buildbucket for the build status
[00:01:46.940] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:46.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:181:0) after 1m0s
[00:02:46.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:181:0)
[00:02:46.977] Timer tick, asking Buildbucket for the build status
[00:02:47.081] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:47.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:182:0) after 1m0s
[00:03:47.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:182:0)
[00:03:47.110] Timer tick, asking Buildbucket for the build status
[00:03:47.226] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:47.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:183:0) after 1m0s
[00:04:47.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:183:0)
[00:04:47.248] Timer tick, asking Buildbucket for the build status
[00:04:47.312] Build 8932657497275587360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:47.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9098087559543178608:184:0) after 1m0s
[00:05:14.873] Received PubSub notification, asking Buildbucket for the build status
[00:05:14.910] Build 8932657497275587360: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[00:05:14.910] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1539561913926316",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539550989802050",
"failure_reason": "INFRA_FAILURE",
"id": "8932657497275587360",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"98cc77946ed5ceb4cbda3b0087dfda100b0d4c35\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"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\": [\"3809-a31bbe1\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm591-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1539550993146131",
"status": "COMPLETED",
"status_changed_ts": "1539561914372231",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/17174",
"builder:Deterministic Linux",
"buildset:commit/git/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098087559543178608",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_dimension:builder:Deterministic Linux",
"swarming_dimension:caches:builder_26450780b77752b73235b8dcd76e4371340e7d14b7166082470bfa623c3e2d62_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/17174",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932657497275587360",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Deterministic Linux",
"swarming_tag:buildset:commit/git/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/98cc77946ed5ceb4cbda3b0087dfda100b0d4c35",
"swarming_tag:caches:builder_26450780b77752b73235b8dcd76e4371340e7d14b7166082470bfa623c3e2d62_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/8932657497275587360/+/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:9098087559543178608",
"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:9d4e55f09f057cb6c6ed423e82fe5a8bae98ab2b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:408d3559acff0a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1539561914373705",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Linux/17174",
"utcnow_ts": "1539561914900713"
}
}
[00:05:14.910] Invocation finished in 3h2m6.653897837s with status FAILED