[17:53:24.533] New invocation is queued and will start shortly
[17:53:25.760] Starting the invocation (attempt 1)
[17:53:25.795] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:53:25.795] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:53:25.795] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9097193526594189760",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1c6f831f14152cf4ca9e23563757d61524487234\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9097193526594189760",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/1c6f831f14152cf4ca9e23563757d61524487234",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c6f831f14152cf4ca9e23563757d61524487234",
"gitiles_ref:refs/heads/master"
]
}
[17:53:27.162] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540403605962968",
"id": "8931763464432726240",
"lease_expiration_ts": "1540522406828939",
"lease_key": "1836751531",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1c6f831f14152cf4ca9e23563757d61524487234\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540403607051113",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10509",
"builder:Windows deterministic",
"buildset:commit/git/1c6f831f14152cf4ca9e23563757d61524487234",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c6f831f14152cf4ca9e23563757d61524487234",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097193526594189760",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10509",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8931763464432726240",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/1c6f831f14152cf4ca9e23563757d61524487234",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c6f831f14152cf4ca9e23563757d61524487234",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/8931763464432726240/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"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:9097193526594189760",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:ae657075c69d8bee7b2f68ce50de3a7cde434ac0",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40c0073bf49ce210",
"user_agent:luci-scheduler"
],
"updated_ts": "1540403607051252",
"url": "https://ci.chromium.org/b/8931763464432726240",
"utcnow_ts": "1540403607148435"
}
}
[17:53:27.162] Task URL: https://ci.chromium.org/b/8931763464432726240
[17:53:27.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:2:0) after 1m0s
[17:53:29.330] Received PubSub notification, asking Buildbucket for the build status
[17:53:29.372] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:27.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:2:0)
[17:54:27.182] Timer tick, asking Buildbucket for the build status
[17:54:27.232] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:27.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:4:0) after 1m0s
[17:55:27.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:4:0)
[17:55:27.255] Timer tick, asking Buildbucket for the build status
[17:55:27.300] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:27.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:5:0) after 1m0s
[17:56:27.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:5:0)
[17:56:27.318] Timer tick, asking Buildbucket for the build status
[17:56:27.351] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:27.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:6:0) after 1m0s
[17:57:27.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:6:0)
[17:57:27.419] Timer tick, asking Buildbucket for the build status
[17:57:27.462] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:27.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:7:0) after 1m0s
[17:58:27.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:7:0)
[17:58:27.529] Timer tick, asking Buildbucket for the build status
[17:58:27.596] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:27.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:8:0) after 1m0s
[17:59:27.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:8:0)
[17:59:27.629] Timer tick, asking Buildbucket for the build status
[17:59:27.697] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:9:0) after 1m0s
[18:00:27.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:9:0)
[18:00:27.740] Timer tick, asking Buildbucket for the build status
[18:00:27.779] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:27.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:10:0) after 1m0s
[18:01:27.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:10:0)
[18:01:27.976] Timer tick, asking Buildbucket for the build status
[18:01:28.017] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:28.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:11:0) after 1m0s
[18:02:28.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:11:0)
[18:02:28.377] Timer tick, asking Buildbucket for the build status
[18:02:28.475] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:28.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:12:0) after 1m0s
[18:03:28.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:12:0)
[18:03:28.531] Timer tick, asking Buildbucket for the build status
[18:03:28.660] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:28.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:13:0) after 1m0s
[18:04:28.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:13:0)
[18:04:28.798] Timer tick, asking Buildbucket for the build status
[18:04:29.075] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:29.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:14:0) after 1m0s
[18:05:29.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:14:0)
[18:05:29.124] Timer tick, asking Buildbucket for the build status
[18:05:29.256] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:29.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:15:0) after 1m0s
[18:06:29.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:15:0)
[18:06:29.289] Timer tick, asking Buildbucket for the build status
[18:06:29.389] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:29.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:16:0) after 1m0s
[18:07:29.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:16:0)
[18:07:29.418] Timer tick, asking Buildbucket for the build status
[18:07:29.481] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:29.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:17:0) after 1m0s
[18:08:29.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:17:0)
[18:08:29.509] Timer tick, asking Buildbucket for the build status
[18:08:29.568] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:29.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:18:0) after 1m0s
[18:09:29.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:18:0)
[18:09:29.611] Timer tick, asking Buildbucket for the build status
[18:09:29.714] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:29.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:19:0) after 1m0s
[18:10:29.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:19:0)
[18:10:29.801] Timer tick, asking Buildbucket for the build status
[18:10:29.974] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:29.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:20:0) after 1m0s
[18:11:30.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:20:0)
[18:11:30.004] Timer tick, asking Buildbucket for the build status
[18:11:30.046] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:30.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:21:0) after 1m0s
[18:12:30.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:21:0)
[18:12:30.097] Timer tick, asking Buildbucket for the build status
[18:12:30.259] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:30.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:22:0) after 1m0s
[18:13:30.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:22:0)
[18:13:30.287] Timer tick, asking Buildbucket for the build status
[18:13:30.426] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:30.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:23:0) after 1m0s
[18:14:30.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:23:0)
[18:14:30.451] Timer tick, asking Buildbucket for the build status
[18:14:30.588] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:30.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:24:0) after 1m0s
[18:15:30.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:24:0)
[18:15:30.609] Timer tick, asking Buildbucket for the build status
[18:15:30.681] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:30.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:25:0) after 1m0s
[18:16:30.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:25:0)
[18:16:30.778] Timer tick, asking Buildbucket for the build status
[18:16:30.823] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:30.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:26:0) after 1m0s
[18:17:30.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:26:0)
[18:17:30.855] Timer tick, asking Buildbucket for the build status
[18:17:30.981] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:30.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:27:0) after 1m0s
[18:18:31.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:27:0)
[18:18:31.010] Timer tick, asking Buildbucket for the build status
[18:18:31.135] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:31.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:28:0) after 1m0s
[18:19:31.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:28:0)
[18:19:31.158] Timer tick, asking Buildbucket for the build status
[18:19:31.206] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:31.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:29:0) after 1m0s
[18:20:31.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:29:0)
[18:20:31.229] Timer tick, asking Buildbucket for the build status
[18:20:31.306] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:31.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:30:0) after 1m0s
[18:21:31.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:30:0)
[18:21:31.342] Timer tick, asking Buildbucket for the build status
[18:21:31.391] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:31.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:31:0) after 1m0s
[18:22:31.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:31:0)
[18:22:31.492] Timer tick, asking Buildbucket for the build status
[18:22:31.540] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:31.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:32:0) after 1m0s
[18:23:31.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:32:0)
[18:23:31.563] Timer tick, asking Buildbucket for the build status
[18:23:31.669] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:33:0) after 1m0s
[18:24:31.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:33:0)
[18:24:31.704] Timer tick, asking Buildbucket for the build status
[18:24:31.844] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:31.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:34:0) after 1m0s
[18:25:31.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:34:0)
[18:25:31.871] Timer tick, asking Buildbucket for the build status
[18:25:31.944] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:31.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:35:0) after 1m0s
[18:26:31.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:35:0)
[18:26:31.978] Timer tick, asking Buildbucket for the build status
[18:26:32.012] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:32.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:36:0) after 1m0s
[18:27:32.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:36:0)
[18:27:32.047] Timer tick, asking Buildbucket for the build status
[18:27:32.139] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:32.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:37:0) after 1m0s
[18:28:32.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:37:0)
[18:28:32.159] Timer tick, asking Buildbucket for the build status
[18:28:32.279] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:32.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:38:0) after 1m0s
[18:29:32.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:38:0)
[18:29:32.341] Timer tick, asking Buildbucket for the build status
[18:29:32.415] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:32.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:39:0) after 1m0s
[18:30:32.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:39:0)
[18:30:32.434] Timer tick, asking Buildbucket for the build status
[18:30:32.544] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:32.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:40:0) after 1m0s
[18:31:32.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:40:0)
[18:31:32.567] Timer tick, asking Buildbucket for the build status
[18:31:32.602] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:32.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:41:0) after 1m0s
[18:32:32.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:41:0)
[18:32:32.682] Timer tick, asking Buildbucket for the build status
[18:32:32.762] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:32.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:42:0) after 1m0s
[18:33:32.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:42:0)
[18:33:32.784] Timer tick, asking Buildbucket for the build status
[18:33:32.828] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:32.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:43:0) after 1m0s
[18:34:32.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:43:0)
[18:34:32.852] Timer tick, asking Buildbucket for the build status
[18:34:32.935] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:32.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:44:0) after 1m0s
[18:35:32.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:44:0)
[18:35:32.990] Timer tick, asking Buildbucket for the build status
[18:35:33.138] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:33.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:45:0) after 1m0s
[18:36:33.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:45:0)
[18:36:33.159] Timer tick, asking Buildbucket for the build status
[18:36:33.192] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:33.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:46:0) after 1m0s
[18:37:33.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:46:0)
[18:37:33.214] Timer tick, asking Buildbucket for the build status
[18:37:33.285] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:33.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:47:0) after 1m0s
[18:38:33.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:47:0)
[18:38:33.311] Timer tick, asking Buildbucket for the build status
[18:38:33.350] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:33.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:48:0) after 1m0s
[18:39:33.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:48:0)
[18:39:33.371] Timer tick, asking Buildbucket for the build status
[18:39:33.428] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:33.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:49:0) after 1m0s
[18:40:33.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:49:0)
[18:40:33.454] Timer tick, asking Buildbucket for the build status
[18:40:33.548] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:33.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:50:0) after 1m0s
[18:41:33.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:50:0)
[18:41:33.581] Timer tick, asking Buildbucket for the build status
[18:41:33.632] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:33.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:51:0) after 1m0s
[18:42:33.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:51:0)
[18:42:33.657] Timer tick, asking Buildbucket for the build status
[18:42:33.709] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:33.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:52:0) after 1m0s
[18:43:33.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:52:0)
[18:43:33.728] Timer tick, asking Buildbucket for the build status
[18:43:33.773] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:33.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:53:0) after 1m0s
[18:44:33.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:53:0)
[18:44:33.807] Timer tick, asking Buildbucket for the build status
[18:44:33.860] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:33.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:54:0) after 1m0s
[18:45:33.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:54:0)
[18:45:33.914] Timer tick, asking Buildbucket for the build status
[18:45:34.057] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:34.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:55:0) after 1m0s
[18:46:34.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:55:0)
[18:46:34.123] Timer tick, asking Buildbucket for the build status
[18:46:34.208] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:34.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:56:0) after 1m0s
[18:47:34.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:56:0)
[18:47:34.228] Timer tick, asking Buildbucket for the build status
[18:47:34.290] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:34.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:57:0) after 1m0s
[18:48:34.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:57:0)
[18:48:34.373] Timer tick, asking Buildbucket for the build status
[18:48:34.486] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:34.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:58:0) after 1m0s
[18:49:34.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:58:0)
[18:49:34.516] Timer tick, asking Buildbucket for the build status
[18:49:34.559] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:34.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:59:0) after 1m0s
[18:50:34.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:59:0)
[18:50:34.603] Timer tick, asking Buildbucket for the build status
[18:50:34.648] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:34.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:60:0) after 1m0s
[18:51:34.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:60:0)
[18:51:34.695] Timer tick, asking Buildbucket for the build status
[18:51:34.788] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:34.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:61:0) after 1m0s
[18:52:34.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:61:0)
[18:52:34.817] Timer tick, asking Buildbucket for the build status
[18:52:34.869] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:34.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:62:0) after 1m0s
[18:53:34.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:62:0)
[18:53:34.908] Timer tick, asking Buildbucket for the build status
[18:53:35.009] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:35.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:63:0) after 1m0s
[18:54:35.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:63:0)
[18:54:35.085] Timer tick, asking Buildbucket for the build status
[18:54:35.128] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:35.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:64:0) after 1m0s
[18:55:35.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:64:0)
[18:55:35.223] Timer tick, asking Buildbucket for the build status
[18:55:35.390] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:35.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:65:0) after 1m0s
[18:56:35.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:65:0)
[18:56:35.423] Timer tick, asking Buildbucket for the build status
[18:56:35.464] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:35.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:66:0) after 1m0s
[18:57:35.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:66:0)
[18:57:35.488] Timer tick, asking Buildbucket for the build status
[18:57:35.530] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:35.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:67:0) after 1m0s
[18:58:35.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:67:0)
[18:58:35.571] Timer tick, asking Buildbucket for the build status
[18:58:35.616] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:35.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:68:0) after 1m0s
[18:59:35.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:68:0)
[18:59:35.638] Timer tick, asking Buildbucket for the build status
[18:59:35.782] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:35.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:69:0) after 1m0s
[19:00:35.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:69:0)
[19:00:35.802] Timer tick, asking Buildbucket for the build status
[19:00:35.900] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:35.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:70:0) after 1m0s
[19:01:35.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:70:0)
[19:01:35.932] Timer tick, asking Buildbucket for the build status
[19:01:36.059] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:36.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:71:0) after 1m0s
[19:02:36.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:71:0)
[19:02:36.082] Timer tick, asking Buildbucket for the build status
[19:02:36.135] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:36.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:72:0) after 1m0s
[19:03:36.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:72:0)
[19:03:36.164] Timer tick, asking Buildbucket for the build status
[19:03:36.213] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:36.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:73:0) after 1m0s
[19:04:36.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:73:0)
[19:04:36.233] Timer tick, asking Buildbucket for the build status
[19:04:36.267] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:36.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:74:0) after 1m0s
[19:05:36.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:74:0)
[19:05:36.296] Timer tick, asking Buildbucket for the build status
[19:05:36.372] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:36.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:75:0) after 1m0s
[19:06:36.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:75:0)
[19:06:36.391] Timer tick, asking Buildbucket for the build status
[19:06:36.435] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:36.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:76:0) after 1m0s
[19:07:36.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:76:0)
[19:07:36.456] Timer tick, asking Buildbucket for the build status
[19:07:36.582] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:36.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:77:0) after 1m0s
[19:08:36.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:77:0)
[19:08:36.637] Timer tick, asking Buildbucket for the build status
[19:08:36.671] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:36.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:78:0) after 1m0s
[19:09:36.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:78:0)
[19:09:36.822] Timer tick, asking Buildbucket for the build status
[19:09:36.987] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:36.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:79:0) after 1m0s
[19:10:37.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:79:0)
[19:10:37.074] Timer tick, asking Buildbucket for the build status
[19:10:37.111] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:37.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:80:0) after 1m0s
[19:11:37.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:80:0)
[19:11:37.268] Timer tick, asking Buildbucket for the build status
[19:11:37.338] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:37.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:81:0) after 1m0s
[19:12:37.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:81:0)
[19:12:37.359] Timer tick, asking Buildbucket for the build status
[19:12:37.464] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:37.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:82:0) after 1m0s
[19:13:37.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:82:0)
[19:13:37.613] Timer tick, asking Buildbucket for the build status
[19:13:37.759] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:37.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:83:0) after 1m0s
[19:14:37.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:83:0)
[19:14:37.892] Timer tick, asking Buildbucket for the build status
[19:14:37.958] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:37.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:84:0) after 1m0s
[19:15:38.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:84:0)
[19:15:38.131] Timer tick, asking Buildbucket for the build status
[19:15:38.246] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:38.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:85:0) after 1m0s
[19:16:38.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:85:0)
[19:16:38.350] Timer tick, asking Buildbucket for the build status
[19:16:38.506] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:38.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:86:0) after 1m0s
[19:17:38.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:86:0)
[19:17:38.573] Timer tick, asking Buildbucket for the build status
[19:17:38.658] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:38.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:87:0) after 1m0s
[19:18:38.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:87:0)
[19:18:38.726] Timer tick, asking Buildbucket for the build status
[19:18:38.792] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:38.792] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:88:0) after 1m0s
[19:19:38.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:88:0)
[19:19:38.820] Timer tick, asking Buildbucket for the build status
[19:19:38.903] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:38.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:89:0) after 1m0s
[19:20:39.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:89:0)
[19:20:39.087] Timer tick, asking Buildbucket for the build status
[19:20:39.142] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:39.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:90:0) after 1m0s
[19:21:39.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:90:0)
[19:21:39.312] Timer tick, asking Buildbucket for the build status
[19:21:39.638] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:39.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:91:0) after 1m0s
[19:22:39.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:91:0)
[19:22:39.737] Timer tick, asking Buildbucket for the build status
[19:22:39.863] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:39.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:92:0) after 1m0s
[19:23:39.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:92:0)
[19:23:39.927] Timer tick, asking Buildbucket for the build status
[19:23:40.087] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:40.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:93:0) after 1m0s
[19:24:40.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:93:0)
[19:24:40.111] Timer tick, asking Buildbucket for the build status
[19:24:40.340] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:40.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:94:0) after 1m0s
[19:25:40.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:94:0)
[19:25:40.412] Timer tick, asking Buildbucket for the build status
[19:25:40.497] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:40.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:95:0) after 1m0s
[19:26:40.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:95:0)
[19:26:40.528] Timer tick, asking Buildbucket for the build status
[19:26:40.610] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:40.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:96:0) after 1m0s
[19:27:40.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:96:0)
[19:27:40.660] Timer tick, asking Buildbucket for the build status
[19:27:40.698] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:97:0) after 1m0s
[19:28:40.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:97:0)
[19:28:40.765] Timer tick, asking Buildbucket for the build status
[19:28:40.880] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:40.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:98:0) after 1m0s
[19:29:40.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:98:0)
[19:29:40.910] Timer tick, asking Buildbucket for the build status
[19:29:41.075] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:41.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:99:0) after 1m0s
[19:30:41.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:99:0)
[19:30:41.213] Timer tick, asking Buildbucket for the build status
[19:30:41.260] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:41.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:100:0) after 1m0s
[19:31:41.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:100:0)
[19:31:41.323] Timer tick, asking Buildbucket for the build status
[19:31:41.385] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:101:0) after 1m0s
[19:32:41.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:101:0)
[19:32:41.434] Timer tick, asking Buildbucket for the build status
[19:32:41.501] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:41.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:102:0) after 1m0s
[19:33:41.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:102:0)
[19:33:41.539] Timer tick, asking Buildbucket for the build status
[19:33:41.647] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:41.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:103:0) after 1m0s
[19:34:41.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:103:0)
[19:34:41.675] Timer tick, asking Buildbucket for the build status
[19:34:41.717] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:104:0) after 1m0s
[19:35:41.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:104:0)
[19:35:41.794] Timer tick, asking Buildbucket for the build status
[19:35:41.854] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:41.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:105:0) after 1m0s
[19:36:41.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:105:0)
[19:36:41.912] Timer tick, asking Buildbucket for the build status
[19:36:42.041] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:42.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:106:0) after 1m0s
[19:37:42.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:106:0)
[19:37:42.065] Timer tick, asking Buildbucket for the build status
[19:37:42.174] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:42.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:107:0) after 1m0s
[19:38:42.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:107:0)
[19:38:42.219] Timer tick, asking Buildbucket for the build status
[19:38:42.269] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:42.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:108:0) after 1m0s
[19:39:42.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:108:0)
[19:39:42.293] Timer tick, asking Buildbucket for the build status
[19:39:42.348] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:42.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:109:0) after 1m0s
[19:40:42.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:109:0)
[19:40:42.470] Timer tick, asking Buildbucket for the build status
[19:40:42.503] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:42.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:110:0) after 1m0s
[19:41:42.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:110:0)
[19:41:42.701] Timer tick, asking Buildbucket for the build status
[19:41:42.918] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:42.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:111:0) after 1m0s
[19:42:43.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:111:0)
[19:42:43.015] Timer tick, asking Buildbucket for the build status
[19:42:43.068] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:43.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:112:0) after 1m0s
[19:43:43.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:112:0)
[19:43:43.099] Timer tick, asking Buildbucket for the build status
[19:43:43.292] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:43.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:113:0) after 1m0s
[19:44:43.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:113:0)
[19:44:43.325] Timer tick, asking Buildbucket for the build status
[19:44:43.443] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:43.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:114:0) after 1m0s
[19:45:43.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:114:0)
[19:45:43.472] Timer tick, asking Buildbucket for the build status
[19:45:43.514] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:43.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:115:0) after 1m0s
[19:46:43.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:115:0)
[19:46:43.538] Timer tick, asking Buildbucket for the build status
[19:46:43.681] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:43.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:116:0) after 1m0s
[19:47:43.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:116:0)
[19:47:43.711] Timer tick, asking Buildbucket for the build status
[19:47:43.763] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:43.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:117:0) after 1m0s
[19:48:43.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:117:0)
[19:48:43.787] Timer tick, asking Buildbucket for the build status
[19:48:43.853] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:43.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:118:0) after 1m0s
[19:49:43.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:118:0)
[19:49:43.902] Timer tick, asking Buildbucket for the build status
[19:49:43.952] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:43.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:119:0) after 1m0s
[19:50:43.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:119:0)
[19:50:43.976] Timer tick, asking Buildbucket for the build status
[19:50:44.015] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:44.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:120:0) after 1m0s
[19:51:44.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:120:0)
[19:51:44.043] Timer tick, asking Buildbucket for the build status
[19:51:44.157] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:44.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:121:0) after 1m0s
[19:52:44.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:121:0)
[19:52:44.187] Timer tick, asking Buildbucket for the build status
[19:52:44.267] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:44.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:122:0) after 1m0s
[19:53:44.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:122:0)
[19:53:44.295] Timer tick, asking Buildbucket for the build status
[19:53:44.328] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:44.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:123:0) after 1m0s
[19:54:44.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:123:0)
[19:54:44.417] Timer tick, asking Buildbucket for the build status
[19:54:44.501] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:44.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:124:0) after 1m0s
[19:55:44.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:124:0)
[19:55:44.607] Timer tick, asking Buildbucket for the build status
[19:55:44.682] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:44.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:125:0) after 1m0s
[19:56:44.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:125:0)
[19:56:44.707] Timer tick, asking Buildbucket for the build status
[19:56:44.816] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:44.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:126:0) after 1m0s
[19:57:44.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:126:0)
[19:57:44.842] Timer tick, asking Buildbucket for the build status
[19:57:44.961] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:127:0) after 1m0s
[19:58:45.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:127:0)
[19:58:45.006] Timer tick, asking Buildbucket for the build status
[19:58:45.168] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:45.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:128:0) after 1m0s
[19:59:45.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:128:0)
[19:59:45.189] Timer tick, asking Buildbucket for the build status
[19:59:45.254] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:45.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:129:0) after 1m0s
[20:00:45.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:129:0)
[20:00:45.287] Timer tick, asking Buildbucket for the build status
[20:00:45.391] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:130:0) after 1m0s
[20:01:45.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:130:0)
[20:01:45.424] Timer tick, asking Buildbucket for the build status
[20:01:45.485] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:45.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:131:0) after 1m0s
[20:02:45.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:131:0)
[20:02:45.505] Timer tick, asking Buildbucket for the build status
[20:02:45.556] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:45.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:132:0) after 1m0s
[20:03:45.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:132:0)
[20:03:45.611] Timer tick, asking Buildbucket for the build status
[20:03:45.672] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:133:0) after 1m0s
[20:04:45.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:133:0)
[20:04:45.718] Timer tick, asking Buildbucket for the build status
[20:04:45.758] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:45.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:134:0) after 1m0s
[20:05:45.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:134:0)
[20:05:45.783] Timer tick, asking Buildbucket for the build status
[20:05:45.824] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:45.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:135:0) after 1m0s
[20:06:45.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:135:0)
[20:06:45.891] Timer tick, asking Buildbucket for the build status
[20:06:45.972] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:45.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:136:0) after 1m0s
[20:07:46.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:136:0)
[20:07:46.003] Timer tick, asking Buildbucket for the build status
[20:07:46.064] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:46.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:137:0) after 1m0s
[20:08:46.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:137:0)
[20:08:46.171] Timer tick, asking Buildbucket for the build status
[20:08:46.221] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:46.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:138:0) after 1m0s
[20:09:46.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:138:0)
[20:09:46.247] Timer tick, asking Buildbucket for the build status
[20:09:46.319] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:46.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:139:0) after 1m0s
[20:10:46.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:139:0)
[20:10:46.344] Timer tick, asking Buildbucket for the build status
[20:10:46.407] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:46.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:140:0) after 1m0s
[20:11:46.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:140:0)
[20:11:46.477] Timer tick, asking Buildbucket for the build status
[20:11:46.624] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:46.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:141:0) after 1m0s
[20:12:46.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:141:0)
[20:12:46.650] Timer tick, asking Buildbucket for the build status
[20:12:46.709] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:46.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:142:0) after 1m0s
[20:13:46.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:142:0)
[20:13:46.747] Timer tick, asking Buildbucket for the build status
[20:13:46.814] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:46.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:143:0) after 1m0s
[20:14:46.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:143:0)
[20:14:46.871] Timer tick, asking Buildbucket for the build status
[20:14:46.907] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:46.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:144:0) after 1m0s
[20:15:46.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:144:0)
[20:15:46.950] Timer tick, asking Buildbucket for the build status
[20:15:47.152] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:47.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:145:0) after 1m0s
[20:16:47.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:145:0)
[20:16:47.184] Timer tick, asking Buildbucket for the build status
[20:16:47.260] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:47.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:146:0) after 1m0s
[20:17:47.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:146:0)
[20:17:47.290] Timer tick, asking Buildbucket for the build status
[20:17:47.328] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:47.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:147:0) after 1m0s
[20:18:47.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:147:0)
[20:18:47.359] Timer tick, asking Buildbucket for the build status
[20:18:47.452] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:47.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:148:0) after 1m0s
[20:19:47.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:148:0)
[20:19:47.539] Timer tick, asking Buildbucket for the build status
[20:19:47.725] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:47.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:149:0) after 1m0s
[20:20:47.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:149:0)
[20:20:47.844] Timer tick, asking Buildbucket for the build status
[20:20:47.916] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:47.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:150:0) after 1m0s
[20:21:47.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:150:0)
[20:21:47.961] Timer tick, asking Buildbucket for the build status
[20:21:48.030] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:48.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:151:0) after 1m0s
[20:22:48.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:151:0)
[20:22:48.052] Timer tick, asking Buildbucket for the build status
[20:22:48.115] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:152:0) after 1m0s
[20:23:48.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:152:0)
[20:23:48.142] Timer tick, asking Buildbucket for the build status
[20:23:48.234] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:48.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:153:0) after 1m0s
[20:24:48.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:153:0)
[20:24:48.269] Timer tick, asking Buildbucket for the build status
[20:24:48.350] Build 8931763464432726240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:48.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097193526594189760:154:0) after 1m0s
[20:25:40.658] Received PubSub notification, asking Buildbucket for the build status
[20:25:40.705] Build 8931763464432726240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:25:40.705] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1540412738902433",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540403605962968",
"id": "8931763464432726240",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1c6f831f14152cf4ca9e23563757d61524487234\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3817-6aedaff\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"1c6f831f14152cf4ca9e23563757d61524487234\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25341}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#602389}\", \"branch\": \"refs/heads/master\", \"revision\": \"1c6f831f14152cf4ca9e23563757d61524487234\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"62ae178357b76b844e28b20fc704bfd11f5bd194\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"19603b9e7b2088c1dc9cef106a5ac478cbafa045\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1540403605962968, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/1c6f831f14152cf4ca9e23563757d61524487234\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c6f831f14152cf4ca9e23563757d61524487234\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9097193526594189760\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8931763464432726240\"}}, \"got_v8_revision\": \"8bc0f79a45048636adca4b808041722813647884\", \"got_v8_revision_cp\": \"refs/heads/7.2.101@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10509, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"7dd0587ce6152bee3d92208ed8d0741c6acfa03f\", \"notification_helper_unittests\": \"e588ae8f0f46b4a0b883bdc218e42cfaa43e84dd\", \"gpu_perftests\": \"4938850cd15db97afd0da71223a7f61a875ae017\", \"vr_common_unittests\": \"7769611e40067f4c1cc8808f2977257e5c413216\", \"telemetry_unittests\": \"6401475e8dd11722acde73b2ee3697a44e7c43fc\", \"load_library_perf_tests\": \"b00e53c55f29b9ae77dcf6cd7aac94670d138bff\", \"devtools_closure_compile\": \"c91792ec072b1b20b94788c96b2d3096912a145c\", \"chromedriver_py_tests\": \"44db91a4eb6d6b3104c2bf546b5ad1e318809be4\", \"mojo_core_unittests\": \"22ffe51b635089f5020ca83301806451ab2347e0\", \"install_static_unittests\": \"6a41ecc979d10bd361dbb8b2fb3fc28609df2f15\", \"leveldb_service_unittests\": \"8e26874f1feb7df63c44ec92af6cccc61591cd21\", \"mini_installer_tests\": \"bd027566712d8cf1d9e7e204fa34109f925aaefc\", \"gcp_unittests\": \"53cd9d2dfb4bc060ba89dff4ac110ed73bccb886\", \"sbox_integration_tests\": \"c3151d3b7769d44357f742ef901871854bf2709a\", \"angle_unittests\": \"d3742f73ad4146bf67a4b99887e08acfa0506d4c\", \"cast_unittests\": \"e83a128a30e91c2cc8d86d1f977a2a16cc7f5997\", \"cc_unittests\": \"de67a2287eb5980a20e9c8eb1a93025eca315d7f\", \"blink_common_unittests\": \"e34290442cb10700d055da669ebfdf22a009e8bd\", \"crashpad_tests\": \"185d73effb137097c53e44ecabd1f3f86774c5fe\", \"telemetry_perf_tests_without_chrome\": \"7dea23f4b56c69a9a9364f6309dbb4f0c52f6f64\", \"metrics_python_tests\": \"07a8d3cea8e55263d1fb41d77148d8b56f399df0\", \"message_center_unittests\": \"e11971c6da457c155bcf92630501b577ced83de1\", \"ppapi_unittests\": \"338e8d00728c41e0f3ef2b2f840ac0dfade90ab0\", \"extensions_unittests\": \"edcab5971ae674e3baba07b5bb633467a578a2fb\", \"gl_unittests_ozone\": \"72c5266aadbb238e0fbf00b18ae6996a2fb9f4fa\", \"app_shell_unittests\": \"e1446dabdd71d5907ce7d19e822816915773bdff\", \"chrome_app_unittests\": \"d71217bc76e8dd73e87d24432340c26d1bde67f6\", \"gl_unittests\": \"72c5266aadbb238e0fbf00b18ae6996a2fb9f4fa\", \"gcm_unit_tests\": \"d6e654d48fff67d78939453d8b2c2d8cf8cd8b6d\", \"views_unittests\": \"6124853cddf8fbbf84b382c3c5ad919a0c3d5427\", \"content_shell_crash_test\": \"390e6bfa76fdf4b27d6923af270daeb9df34129b\", \"ui_base_unittests\": \"dbbc830f2fc54f1330d66ec3406786f23c427444\", \"cronet_unittests\": \"7b92792ea02b7ee8f6e96e83f7a5a3532dc97bc8\", \"performance_test_suite\": \"48e354dcd5116e0e9048dfd5b5da600010bf4cef\", \"wm_unittests\": \"2f3ded209228ff89b13a1115aae20c1d6fe44355\", \"boringssl_crypto_tests\": \"58abc42cd1c61ec6ff2786fe8812912a63203113\", \"gin_unittests\": \"6a2be3731ca4fdc0a410d2741f18a0c83df9a6d4\", \"performance_browser_tests\": \"51bb089aeb0a9a6bea3feb58b258ee422f45572a\", \"extensions_browsertests\": \"60bb20f79c5864728d672ecfebc7eb93745b56e9\", \"webkit_python_tests\": \"33ee7e035ad166f87cbd661361d8401f6f9b0ea5\", \"headless_unittests\": \"7f9ea981eba7a9da804901d16ab6888a67c5bf4d\", \"webkit_layout_tests\": \"2bca78bcda8f5876317fc730f4dfa70f314d1077\", \"vr_pixeltests\": \"c0d72accaacaa9c7605f711fde069c79850c35f4\", \"setup_unittests\": \"818a3e754daabc2e4584d44980bd92afe6458307\", \"webkit_unit_tests\": \"3a3c2f39831d7a368eae6a3690f45a6a31f1e8ae\", \"content_unittests\": \"581ea1f71e3c408ee6a943a82eef518158f76216\", \"performance_webview_test_suite\": \"ec408c805ab4d741b1b5d6a69194679ea1a95591\", \"wtf_unittests\": \"dbd5b1846e2c0dc955f8db4080e4c7e4c0444232\", \"webkit_layout_tests_exparchive\": \"546e6a61c4416a878be16aceb02071b1507e29e1\", \"chrome_cleaner_unittests\": \"0a95ed7f2975bc3245593be8665653a954fc2a1b\", \"traffic_annotation_auditor_unittests\": \"07f47b95bcb1f28fefa751209ef1561e909b90cf\", \"libjingle_xmpp_unittests\": \"094d9def4f89ba195de839498e55ed3409398122\", \"remoting_unittests\": \"f4aca49b7dbd2209eadcb2d4dd5da18b5f82c39b\", \"vr_common_perftests\": \"908caade7b75e4229350cff96c780e99ab658db6\", \"filesystem_service_unittests\": \"15190c0b1522551e013759637d5a1afcabff93bc\", \"chrome_elf_import_unittests\": \"88cd5be54feed95242a46206cc9241fe6e5ed193\", \"installer_util_unittests\": \"1372c77ce8fa1722dbbd312030a01b6a6ac58a79\", \"gfx_unittests\": \"e1d5638531cc105881b0ad34b7153ae28c554311\", \"headless_browsertests\": \"5241f59ff4d9bcf9892807b8fc86d8db4d400bb3\", \"capture_unittests\": \"4f42d469521cbdd07aea781bc98643a6301b7758\", \"chrome_elf_unittests\": \"c34085c29d86fc30f7c756fcae655881d8438e3b\", \"telemetry_gpu_unittests\": \"ca1b55cfe89bff30154da2c99144127eee33fb65\", \"command_buffer_perftests\": \"2b0557922844f8107f820d8c1e0ac65a0a478931\", \"media_unittests\": \"168e7a38683ff6bc3f736d440e9d73a05894c5fd\", \"chromedriver_unittests\": \"e53fa785974a9b3735b2290dd9d8e57e5caaa575\", \"views_mus_interactive_ui_tests\": \"ec528f8cc57acb20fd8c0cf3f144cf738fddbb2b\", \"storage_unittests\": \"70ece65d7159c050af3f1aa1bb2239dc9f400a4b\", \"media_service_unittests\": \"ce139ff13eb54449f7ad1623d0419dd8886df92d\", \"compositor_unittests\": \"2d72639a244587ef0a5aad5731e5823082944c81\", \"latency_unittests\": \"58685e7fe184706cad0bcf85945ac3827a20b9ed\", \"video_decode_accelerator_unittest\": \"741ebc6464e8f5ec1f17b215b7df481b5f5a6cef\", \"swiftshader_unittests\": \"d5ad6c61a6735b883805010f8f0dcd42e05df5cd\", \"telemetry_perf_unittests\": \"886a438a076a5a2977cd334370c3a6be60125241\", \"media_blink_unittests\": \"2e1e23553762a641a29603f76ea987ef105e8c7c\", \"views_mus_unittests\": \"138e35831bf9921ff9b66a18bf76729af3d3896d\", \"components_unittests\": \"308da3713dfe9175c8f833ef26d001c2552dd994\", \"snapshot_unittests\": \"d4fb81166b4ecde6cf31653fc3d4899866e63671\", \"accessibility_unittests\": \"725dc99cf3b6665c2b42c37d3552f16c94eecbfb\", \"net_perftests\": \"8aa394892df1c2f8fdbe95c4495c466d0ff5b992\", \"aura_unittests\": \"99ac665f7cb6861bd1314c0db231b856e06a20e4\", \"services_unittests\": \"068ae8275d2520d78ec32db39974e2f8b27b2174\", \"components_perftests\": \"b2724684ba1bc9ff418bf01e7912193e9345349c\", \"events_unittests\": \"b924d0343a780a4be19bb0faa577a643f71e23c0\", \"tracing_perftests\": \"c8962ded4eb2da5d1c4736742aa44a7e2a27b241\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"c146fe04a7997d8d86eee0981bd7e77c86c35321\", \"cacheinvalidation_unittests\": \"5a5fcea4ceb20a4adb0a9866b31788e933b24e24\", \"viz_unittests\": \"e58228cc42ebd77e606f1c1beef82da5402f617a\", \"browser_tests\": \"ccf6e0046bc8ce8991ff6be1e72a7aca90cd15cf\", \"net_unittests\": \"9b018ad96cb9b3244397571455cc0185a5b34390\", \"pdf_unittests\": \"486e0b65c17d06b846a42a4193b6f55ddca22215\", \"boringssl_ssl_tests\": \"4b314380a671dd6b93d05756f1692a294ff727cd\", \"sbox_validation_tests\": \"4ad6badc9d487fa10d273576a2be565b85e21512\", \"elevation_service_unittests\": \"518897ab62fdb354d2088e33f0c91b565cfc5b62\", \"gpu_unittests\": \"02ec7f604c74e1428f494135446b7aa172c4197d\", \"native_theme_unittests\": \"650fe4b56c85e0082b3088bcacd5b1afff462dbe\", \"interactive_ui_tests\": \"351e49fac8f93dd858e45fd52d7e23387772120f\", \"mojo_unittests\": \"ba74b6cf9b2c2ce7b4ac2d380d1c6c8d9a46aeea\", \"url_unittests\": \"f87f488fc7d62c5e40cbf1b3e6a8c704ee3c0b94\", \"media_perftests\": \"48d1f158fa8234a007b8778eebf1b4f6e0147f5c\", \"cronet_tests\": \"494023b33692d5859ba772d9f0a9c39582b9ec48\", \"google_apis_unittests\": \"d955059916a31694e5e4e716fd11649d25e3816e\", \"telemetry_gpu_integration_test\": \"b63bd996136a8bff3606513026059843a8335adb\", \"blink_heap_unittests\": \"7abc99ea1192ed012225dccd683eab68bc5a577b\", \"midi_unittests\": \"5e32507a84fc05b02cbc9d9c2263e06910c3893b\", \"base_unittests\": \"a0b2b60dd88d16202358fa104fb0992e32cd6f98\", \"sync_integration_tests\": \"6901f49534419a71bb190306089653d361b9c326\", \"sql_unittests\": \"6c0317502d776094d48db34142c5ffac3796370f\", \"courgette_unittests\": \"11aeb48c70ab62fe44ed642133db2a281002a9fe\", \"blink_fuzzer_unittests\": \"fd78e4fe53cbd5b540d2c53aa125053d5967b860\", \"gl_tests\": \"b395cdce38b59f1a29cf93cbc2ba3805211bb217\", \"zucchini_unittests\": \"301c58d5bb4bd46e82bbc081158c82e588c94458\", \"ipc_tests\": \"401f0f9c1842a6b199338cd18d07cc953a37b2a3\", \"angle_end2end_tests\": \"57fc0b94296b047244c0cb82ae2aa7e5f435f6ef\", \"blink_platform_unittests\": \"b7d9cf604ee7e051c3c7bc03871cd4832eceae76\", \"components_browsertests\": \"5754ae32370b59dcf9e5f661142f60def2951c59\", \"views_perftests\": \"ca0e137a78c485e2c585398458d724c61c32e1ae\", \"angle_perftests\": \"cec706b8fba7c77c2247270db0dee8aee1877524\", \"display_unittests\": \"b827667a5f30906a813e8816bb5a19c093eb7714\", \"sbox_unittests\": \"c894b145c7f66b082bd2a6a3d37a29791dd3d975\", \"service_manager_unittests\": \"b044a06f45ea5c3410d6c5e092230c5fce60f932\", \"gles2_conform_test\": \"98638c7f4c989d3697cbb73f78e250c4a81c0962\", \"jingle_unittests\": \"b51511bf1346fe7bdf35350c54e430b0f626adcf\", \"skia_unittests\": \"021df7bfa6dace207398f0a3a00cc3c8b9302a83\", \"angle_white_box_tests\": \"2e2ed1ba1d87f54a28266b843d441b80076a943f\", \"crypto_unittests\": \"acfdc1cf6412cd6e629bd55c0600e5f33f6c5901\", \"nacl_loader_unittests\": \"72c831f421fbf93c1a87f0e55b5dff3d2fff7791\", \"unit_tests\": \"634b62082bd8304d2f4639031a9c4d4b4d5e1ce0\", \"content_browsertests\": \"1bd69fb8a3ccb6e9e7895e9023c221a246c2878d\", \"printing_unittests\": \"8cddd214a8a329766c05f3365d887c614cb89463\", \"device_unittests\": \"0fc698e7b4ae547dd29838a3a9d3edae1583ea2d\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1540403608207425",
"status": "COMPLETED",
"status_changed_ts": "1540412739925596",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10509",
"builder:Windows deterministic",
"buildset:commit/git/1c6f831f14152cf4ca9e23563757d61524487234",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c6f831f14152cf4ca9e23563757d61524487234",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097193526594189760",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10509",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8931763464432726240",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/1c6f831f14152cf4ca9e23563757d61524487234",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1c6f831f14152cf4ca9e23563757d61524487234",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/8931763464432726240/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"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:9097193526594189760",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:ae657075c69d8bee7b2f68ce50de3a7cde434ac0",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40c0073bf49ce210",
"user_agent:luci-scheduler"
],
"updated_ts": "1540412739928233",
"url": "https://ci.chromium.org/b/8931763464432726240",
"utcnow_ts": "1540412740691871"
}
}
[20:25:40.705] Invocation finished in 2h32m16.188046956s with status SUCCEEDED