[05:42:56.157] New invocation is queued and will start shortly
[05:42:57.461] Starting the invocation (attempt 1)
[05:42:57.492] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:42:57.492] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:42:57.492] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9101225750499050800",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fe3ac346a9e30b2bba001db47af1521b417ed92a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9101225750499050800",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"gitiles_ref:refs/heads/master"
]
}
[05:42:59.358] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536558177565682",
"id": "8935795688359718720",
"lease_expiration_ts": "1536702179132252",
"lease_key": "861890368",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe3ac346a9e30b2bba001db47af1521b417ed92a\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1536558179276919",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10036",
"builder:Windows deterministic",
"buildset:commit/git/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101225750499050800",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_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/10036",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935795688359718720",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_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/8935795688359718720/+/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:9101225750499050800",
"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:71d843ea58cc76a6b4422ca80f2115179bb30d7f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fdad2a929f83d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1536558179277101",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10036",
"utcnow_ts": "1536558179348096"
}
}
[05:42:59.358] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10036
[05:42:59.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:2:0) after 1m0s
[05:43:01.124] Received PubSub notification, asking Buildbucket for the build status
[05:43:01.172] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:59.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:2:0)
[05:43:59.376] Timer tick, asking Buildbucket for the build status
[05:43:59.433] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:59.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:4:0) after 1m0s
[05:44:59.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:4:0)
[05:44:59.449] Timer tick, asking Buildbucket for the build status
[05:44:59.609] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:59.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:5:0) after 1m0s
[05:45:59.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:5:0)
[05:45:59.628] Timer tick, asking Buildbucket for the build status
[05:45:59.679] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:59.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:6:0) after 1m0s
[05:46:59.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:6:0)
[05:46:59.745] Timer tick, asking Buildbucket for the build status
[05:46:59.890] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:59.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:7:0) after 1m0s
[05:47:59.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:7:0)
[05:47:59.908] Timer tick, asking Buildbucket for the build status
[05:47:59.963] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:59.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:8:0) after 1m0s
[05:48:59.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:8:0)
[05:48:59.992] Timer tick, asking Buildbucket for the build status
[05:49:00.047] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:00.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:9:0) after 1m0s
[05:50:00.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:9:0)
[05:50:00.068] Timer tick, asking Buildbucket for the build status
[05:50:00.133] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:00.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:10:0) after 1m0s
[05:51:00.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:10:0)
[05:51:00.150] Timer tick, asking Buildbucket for the build status
[05:51:00.189] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:00.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:11:0) after 1m0s
[05:52:00.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:11:0)
[05:52:00.222] Timer tick, asking Buildbucket for the build status
[05:52:00.288] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:12:0) after 1m0s
[05:53:00.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:12:0)
[05:53:00.304] Timer tick, asking Buildbucket for the build status
[05:53:00.382] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:00.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:13:0) after 1m0s
[05:54:00.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:13:0)
[05:54:00.403] Timer tick, asking Buildbucket for the build status
[05:54:00.659] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:00.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:14:0) after 1m0s
[05:55:00.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:14:0)
[05:55:00.678] Timer tick, asking Buildbucket for the build status
[05:55:00.793] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:00.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:15:0) after 1m0s
[05:56:00.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:15:0)
[05:56:00.811] Timer tick, asking Buildbucket for the build status
[05:56:00.872] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:00.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:16:0) after 1m0s
[05:57:00.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:16:0)
[05:57:00.895] Timer tick, asking Buildbucket for the build status
[05:57:01.026] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:01.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:17:0) after 1m0s
[05:58:01.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:17:0)
[05:58:01.131] Timer tick, asking Buildbucket for the build status
[05:58:01.205] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:01.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:18:0) after 1m0s
[05:59:01.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:18:0)
[05:59:01.265] Timer tick, asking Buildbucket for the build status
[05:59:01.418] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:01.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:19:0) after 1m0s
[06:00:01.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:19:0)
[06:00:01.497] Timer tick, asking Buildbucket for the build status
[06:00:01.758] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:01.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:20:0) after 1m0s
[06:01:01.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:20:0)
[06:01:01.804] Timer tick, asking Buildbucket for the build status
[06:01:02.039] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:02.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:21:0) after 1m0s
[06:02:02.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:21:0)
[06:02:02.056] Timer tick, asking Buildbucket for the build status
[06:02:02.174] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:02.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:22:0) after 1m0s
[06:03:02.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:22:0)
[06:03:02.296] Timer tick, asking Buildbucket for the build status
[06:03:06.849] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:06.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:23:0) after 1m0s
[06:04:06.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:23:0)
[06:04:06.909] Timer tick, asking Buildbucket for the build status
[06:04:06.964] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:06.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:24:0) after 1m0s
[06:05:06.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:24:0)
[06:05:06.983] Timer tick, asking Buildbucket for the build status
[06:05:07.017] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:07.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:25:0) after 1m0s
[06:06:07.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:25:0)
[06:06:07.048] Timer tick, asking Buildbucket for the build status
[06:06:07.159] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:07.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:26:0) after 1m0s
[06:07:07.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:26:0)
[06:07:07.176] Timer tick, asking Buildbucket for the build status
[06:07:07.240] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:07.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:27:0) after 1m0s
[06:08:07.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:27:0)
[06:08:07.286] Timer tick, asking Buildbucket for the build status
[06:08:07.347] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:07.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:28:0) after 1m0s
[06:09:07.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:28:0)
[06:09:07.365] Timer tick, asking Buildbucket for the build status
[06:09:07.462] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:07.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:29:0) after 1m0s
[06:10:07.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:29:0)
[06:10:07.493] Timer tick, asking Buildbucket for the build status
[06:10:07.526] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:07.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:30:0) after 1m0s
[06:11:07.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:30:0)
[06:11:07.549] Timer tick, asking Buildbucket for the build status
[06:11:07.607] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:07.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:31:0) after 1m0s
[06:12:07.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:31:0)
[06:12:07.627] Timer tick, asking Buildbucket for the build status
[06:12:07.714] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:07.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:32:0) after 1m0s
[06:13:07.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:32:0)
[06:13:07.750] Timer tick, asking Buildbucket for the build status
[06:13:07.804] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:07.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:33:0) after 1m0s
[06:14:07.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:33:0)
[06:14:07.833] Timer tick, asking Buildbucket for the build status
[06:14:07.894] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:07.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:34:0) after 1m0s
[06:15:07.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:34:0)
[06:15:07.944] Timer tick, asking Buildbucket for the build status
[06:15:07.989] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:07.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:35:0) after 1m0s
[06:16:08.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:35:0)
[06:16:08.092] Timer tick, asking Buildbucket for the build status
[06:16:08.201] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:08.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:36:0) after 1m0s
[06:17:08.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:36:0)
[06:17:08.244] Timer tick, asking Buildbucket for the build status
[06:17:08.311] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:08.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:37:0) after 1m0s
[06:18:08.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:37:0)
[06:18:08.362] Timer tick, asking Buildbucket for the build status
[06:18:08.484] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:08.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:38:0) after 1m0s
[06:19:08.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:38:0)
[06:19:08.505] Timer tick, asking Buildbucket for the build status
[06:19:08.549] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:08.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:39:0) after 1m0s
[06:20:08.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:39:0)
[06:20:08.566] Timer tick, asking Buildbucket for the build status
[06:20:08.914] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:08.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:40:0) after 1m0s
[06:21:08.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:40:0)
[06:21:08.931] Timer tick, asking Buildbucket for the build status
[06:21:08.990] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:08.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:41:0) after 1m0s
[06:22:09.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:41:0)
[06:22:09.010] Timer tick, asking Buildbucket for the build status
[06:22:09.055] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:09.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:42:0) after 1m0s
[06:23:09.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:42:0)
[06:23:09.087] Timer tick, asking Buildbucket for the build status
[06:23:09.150] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:09.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:43:0) after 1m0s
[06:24:09.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:43:0)
[06:24:09.167] Timer tick, asking Buildbucket for the build status
[06:24:09.207] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:09.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:44:0) after 1m0s
[06:25:09.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:44:0)
[06:25:09.257] Timer tick, asking Buildbucket for the build status
[06:25:09.318] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:09.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:45:0) after 1m0s
[06:26:09.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:45:0)
[06:26:09.335] Timer tick, asking Buildbucket for the build status
[06:26:09.374] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:09.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:46:0) after 1m0s
[06:27:09.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:46:0)
[06:27:09.395] Timer tick, asking Buildbucket for the build status
[06:27:09.453] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:09.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:47:0) after 1m0s
[06:28:09.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:47:0)
[06:28:09.475] Timer tick, asking Buildbucket for the build status
[06:28:09.545] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:09.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:48:0) after 1m0s
[06:29:09.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:48:0)
[06:29:09.563] Timer tick, asking Buildbucket for the build status
[06:29:09.632] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:09.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:49:0) after 1m0s
[06:30:09.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:49:0)
[06:30:09.666] Timer tick, asking Buildbucket for the build status
[06:30:09.710] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:09.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:50:0) after 1m0s
[06:31:09.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:50:0)
[06:31:09.825] Timer tick, asking Buildbucket for the build status
[06:31:09.891] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:09.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:51:0) after 1m0s
[06:32:10.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:51:0)
[06:32:10.040] Timer tick, asking Buildbucket for the build status
[06:32:10.137] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:10.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:52:0) after 1m0s
[06:33:11.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:52:0)
[06:33:11.068] Timer tick, asking Buildbucket for the build status
[06:33:11.160] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:11.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:53:0) after 1m0s
[06:34:11.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:53:0)
[06:34:11.598] Timer tick, asking Buildbucket for the build status
[06:34:11.657] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:11.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:54:0) after 1m0s
[06:35:11.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:54:0)
[06:35:11.674] Timer tick, asking Buildbucket for the build status
[06:35:11.736] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:11.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:55:0) after 1m0s
[06:36:11.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:55:0)
[06:36:11.857] Timer tick, asking Buildbucket for the build status
[06:36:11.963] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:11.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:56:0) after 1m0s
[06:37:12.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:56:0)
[06:37:12.454] Timer tick, asking Buildbucket for the build status
[06:37:12.544] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:12.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:57:0) after 1m0s
[06:38:13.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:57:0)
[06:38:13.231] Timer tick, asking Buildbucket for the build status
[06:38:13.286] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:13.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:58:0) after 1m0s
[06:39:13.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:58:0)
[06:39:13.400] Timer tick, asking Buildbucket for the build status
[06:39:13.439] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:13.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:59:0) after 1m0s
[06:40:14.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:59:0)
[06:40:14.113] Timer tick, asking Buildbucket for the build status
[06:40:14.267] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:14.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:60:0) after 1m0s
[06:41:14.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:60:0)
[06:41:14.801] Timer tick, asking Buildbucket for the build status
[06:41:14.891] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:14.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:61:0) after 1m0s
[06:42:16.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:61:0)
[06:42:16.044] Timer tick, asking Buildbucket for the build status
[06:42:16.103] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:16.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:62:0) after 1m0s
[06:43:16.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:62:0)
[06:43:16.246] Timer tick, asking Buildbucket for the build status
[06:43:16.300] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:16.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:63:0) after 1m0s
[06:44:17.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:63:0)
[06:44:17.279] Timer tick, asking Buildbucket for the build status
[06:44:17.373] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:17.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:64:0) after 1m0s
[06:45:18.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:64:0)
[06:45:18.729] Timer tick, asking Buildbucket for the build status
[06:45:18.789] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:18.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:65:0) after 1m0s
[06:46:18.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:65:0)
[06:46:18.845] Timer tick, asking Buildbucket for the build status
[06:46:18.901] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:18.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:66:0) after 1m0s
[06:47:18.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:66:0)
[06:47:18.927] Timer tick, asking Buildbucket for the build status
[06:47:19.027] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:19.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:67:0) after 1m0s
[06:48:20.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:67:0)
[06:48:20.153] Timer tick, asking Buildbucket for the build status
[06:48:20.242] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:20.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:68:0) after 1m0s
[06:49:20.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:68:0)
[06:49:20.539] Timer tick, asking Buildbucket for the build status
[06:49:20.589] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:20.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:69:0) after 1m0s
[06:50:21.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:69:0)
[06:50:21.241] Timer tick, asking Buildbucket for the build status
[06:50:21.436] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:21.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:70:0) after 1m0s
[06:51:21.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:70:0)
[06:51:21.755] Timer tick, asking Buildbucket for the build status
[06:51:21.891] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:21.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:71:0) after 1m0s
[06:52:22.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:71:0)
[06:52:22.177] Timer tick, asking Buildbucket for the build status
[06:52:22.367] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:22.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:72:0) after 1m0s
[06:53:22.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:72:0)
[06:53:22.384] Timer tick, asking Buildbucket for the build status
[06:53:22.442] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:22.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:73:0) after 1m0s
[06:54:22.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:73:0)
[06:54:22.464] Timer tick, asking Buildbucket for the build status
[06:54:22.622] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:22.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:74:0) after 1m0s
[06:55:22.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:74:0)
[06:55:22.657] Timer tick, asking Buildbucket for the build status
[06:55:22.687] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:22.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:75:0) after 1m0s
[06:56:23.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:75:0)
[06:56:23.350] Timer tick, asking Buildbucket for the build status
[06:56:23.403] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:23.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:76:0) after 1m0s
[06:57:23.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:76:0)
[06:57:23.759] Timer tick, asking Buildbucket for the build status
[06:57:23.796] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:23.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:77:0) after 1m0s
[06:58:25.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:77:0)
[06:58:25.030] Timer tick, asking Buildbucket for the build status
[06:58:25.142] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:25.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:78:0) after 1m0s
[06:59:26.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:78:0)
[06:59:26.415] Timer tick, asking Buildbucket for the build status
[06:59:26.539] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:26.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:79:0) after 1m0s
[07:00:26.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:79:0)
[07:00:26.778] Timer tick, asking Buildbucket for the build status
[07:00:26.852] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:26.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:80:0) after 1m0s
[07:01:28.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:80:0)
[07:01:28.463] Timer tick, asking Buildbucket for the build status
[07:01:28.567] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:28.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:81:0) after 1m0s
[07:02:29.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:81:0)
[07:02:29.131] Timer tick, asking Buildbucket for the build status
[07:02:29.291] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:29.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:82:0) after 1m0s
[07:03:30.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:82:0)
[07:03:30.510] Timer tick, asking Buildbucket for the build status
[07:03:30.694] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:30.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:83:0) after 1m0s
[07:04:31.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:83:0)
[07:04:31.816] Timer tick, asking Buildbucket for the build status
[07:04:31.863] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:31.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:84:0) after 1m0s
[07:05:33.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:84:0)
[07:05:33.973] Timer tick, asking Buildbucket for the build status
[07:05:34.142] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:34.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:85:0) after 1m0s
[07:06:34.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:85:0)
[07:06:34.969] Timer tick, asking Buildbucket for the build status
[07:06:35.034] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:35.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:86:0) after 1m0s
[07:07:35.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:86:0)
[07:07:35.603] Timer tick, asking Buildbucket for the build status
[07:07:35.730] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:35.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:87:0) after 1m0s
[07:08:37.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:87:0)
[07:08:37.379] Timer tick, asking Buildbucket for the build status
[07:08:37.542] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:37.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:88:0) after 1m0s
[07:09:37.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:88:0)
[07:09:37.936] Timer tick, asking Buildbucket for the build status
[07:09:37.995] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:37.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:89:0) after 1m0s
[07:10:38.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:89:0)
[07:10:38.343] Timer tick, asking Buildbucket for the build status
[07:10:38.404] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:38.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:90:0) after 1m0s
[07:11:39.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:90:0)
[07:11:39.322] Timer tick, asking Buildbucket for the build status
[07:11:39.376] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:39.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:91:0) after 1m0s
[07:12:39.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:91:0)
[07:12:39.395] Timer tick, asking Buildbucket for the build status
[07:12:39.441] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:39.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:92:0) after 1m0s
[07:13:39.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:92:0)
[07:13:39.510] Timer tick, asking Buildbucket for the build status
[07:13:39.576] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:39.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:93:0) after 1m0s
[07:14:40.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:93:0)
[07:14:40.746] Timer tick, asking Buildbucket for the build status
[07:14:40.802] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:40.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:94:0) after 1m0s
[07:15:42.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:94:0)
[07:15:42.086] Timer tick, asking Buildbucket for the build status
[07:15:42.119] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:42.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:95:0) after 1m0s
[07:16:43.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:95:0)
[07:16:43.524] Timer tick, asking Buildbucket for the build status
[07:16:43.582] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:43.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:96:0) after 1m0s
[07:17:43.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:96:0)
[07:17:43.602] Timer tick, asking Buildbucket for the build status
[07:17:43.892] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:43.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:97:0) after 1m0s
[07:18:43.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:97:0)
[07:18:43.925] Timer tick, asking Buildbucket for the build status
[07:18:44.212] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:44.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:98:0) after 1m0s
[07:19:44.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:98:0)
[07:19:44.944] Timer tick, asking Buildbucket for the build status
[07:19:50.767] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:50.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:99:0) after 1m0s
[07:20:50.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:99:0)
[07:20:50.790] Timer tick, asking Buildbucket for the build status
[07:20:50.873] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:50.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:100:0) after 1m0s
[07:21:51.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:100:0)
[07:21:51.249] Timer tick, asking Buildbucket for the build status
[07:21:51.320] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:51.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:101:0) after 1m0s
[07:22:52.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:101:0)
[07:22:52.826] Timer tick, asking Buildbucket for the build status
[07:22:52.896] Build 8935795688359718720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:52.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101225750499050800:102:0) after 1m0s
[07:22:55.028] Received PubSub notification, asking Buildbucket for the build status
[07:22:55.067] Build 8935795688359718720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:22:55.067] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1536564173212235",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536558177565682",
"id": "8935795688359718720",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe3ac346a9e30b2bba001db47af1521b417ed92a\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8935795688359718720/+/annotations\"}, \"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\": [\"3769-3c22b45\"], \"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\": \"cb6ec4b1f91af259cbdfd1bd22bb98ed5551955e\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"fe3ac346a9e30b2bba001db47af1521b417ed92a\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24631}\", \"$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@{#589828}\", \"branch\": \"refs/heads/master\", \"revision\": \"fe3ac346a9e30b2bba001db47af1521b417ed92a\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d7027dc081cb96791b51524210aa249eb301c056\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"a735ee2f6df8ec7ef55207e7fdffcbac87b900af\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1536558177565682, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/fe3ac346a9e30b2bba001db47af1521b417ed92a\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe3ac346a9e30b2bba001db47af1521b417ed92a\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9101225750499050800\", \"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\": \"8935795688359718720\"}}, \"got_v8_revision\": \"abc91d4174d4019369c60b31b45a440e8ece6682\", \"got_v8_revision_cp\": \"refs/heads/7.1.70@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10036, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"a37146f56f2aa84f880c56cbcb4ebbb940a68fe3\", \"notification_helper_unittests\": \"298a1124970e07c82ee4a2d069c73622a8d69667\", \"gpu_perftests\": \"ce52b98fbd5493360bdb6e2ee3167edd0a702631\", \"vr_common_unittests\": \"b098d751639027c6a42541f30b6f41a4a4ec63b4\", \"telemetry_unittests\": \"979f9a995c737af965a71844b6b41d5fc7055480\", \"load_library_perf_tests\": \"f8433b5977ac918e2ed1b42981639446302dfff6\", \"devtools_closure_compile\": \"7d01ddf637cd20cfde26adfb03767a3010c537fd\", \"chromedriver_py_tests\": \"4ff4ef1813c4a7f175078fe17ab77e4903e03348\", \"mojo_core_unittests\": \"96bb3564df74911aa49fcd095a19d0bc65d28ac8\", \"install_static_unittests\": \"f30fa77e909750b502fb327804c6f7ab168acdfa\", \"leveldb_service_unittests\": \"feee4adf625ac48555632abfce077fb4e042025b\", \"mini_installer_tests\": \"ac718ed8efdd618c8d966c913a938bbeaaafba52\", \"jingle_unittests\": \"24c0b401e32dd14401ac0ad404a30da8a01e086e\", \"sbox_integration_tests\": \"6a8efcace5926889b88ab179d0ff84f14b1372f3\", \"angle_unittests\": \"157d877423624e3bcc3b29cb1907766251acf286\", \"cast_unittests\": \"9376b3e4eda9f0793407dfc60c3aba8e51fe2e60\", \"cc_unittests\": \"448906423a0e9fd703826e66e1aefa32ee4d1dbf\", \"blink_common_unittests\": \"f426df9b29d55f82c5b4d32a7cd67f2e6e07a2aa\", \"crashpad_tests\": \"41e0b457c743f9062ad8fcd8f259652aea33e7f7\", \"telemetry_perf_tests_without_chrome\": \"fc7faf584f6f0bd0b821e912023ea312639271b4\", \"metrics_python_tests\": \"a54ccbdcb57a0d4e104d4d9469fa880fb724183b\", \"message_center_unittests\": \"983b7cc79b94f3fad2d9b3c6fb89024942780b3b\", \"ppapi_unittests\": \"b78e061c2927bfd6af6fb094c0d1b8dd803433da\", \"extensions_unittests\": \"e88000d079a892cf6ff6c0df7843609daa414499\", \"gl_unittests_ozone\": \"64ee98d9aa50eed393b0aeac24bebbb2d2b9d92a\", \"app_shell_unittests\": \"e55dbbafe4760ed62ff6cd3bfd8c0c70e3699f5f\", \"chrome_app_unittests\": \"597e5f5783632a066e471edf6b5bf574ab3cfbac\", \"gl_unittests\": \"64ee98d9aa50eed393b0aeac24bebbb2d2b9d92a\", \"gcm_unit_tests\": \"75f26ec4636a1b4424a72eea834adff8877dd7ee\", \"views_unittests\": \"caea6372c5b741b75cfe540f0fa032869c2576c4\", \"content_shell_crash_test\": \"d13e988a9f79ca4d43141cdc14bd607ae342d60b\", \"ui_base_unittests\": \"7f60f3caf18d0b4ef117987d258afe489a36bec2\", \"gles2_conform_test\": \"ddbc258d08fca836cec02de445efa105abeeba1d\", \"cronet_unittests\": \"2d533a1939c35882d258be3ebd69942053e8ce5b\", \"performance_test_suite\": \"0902a483017e019075438c0596e60975fea70960\", \"wm_unittests\": \"40af2c53b68930e83a80e5aa06e57db5d4f3798c\", \"boringssl_crypto_tests\": \"87b6c3e0c6ea49be86b5b64d51b5807a6bf98bd7\", \"gin_unittests\": \"ac11f980b116166ac6c4e3e2c50198f2b2f47367\", \"performance_browser_tests\": \"c6a958067d9fe88f1e859182e9aac974071eb0e9\", \"extensions_browsertests\": \"c136f07224351d5601ceb93efba4328a3e6b504e\", \"webkit_python_tests\": \"f8ca39d6669c073fe7e4d04a09197434a333992f\", \"headless_unittests\": \"24df8af3564ebf87d231c61b52e3fe1e37671198\", \"webkit_layout_tests\": \"92aa3d3de014bd8837279b17a12f60c6a73fb7a3\", \"vr_pixeltests\": \"9a80d524412460f703a01c8903f84b5b42664988\", \"setup_unittests\": \"5474b6ca50a77899d9f63802cd67f32d669ca588\", \"webkit_unit_tests\": \"d119b2d6b6aefb325e4fb3c6949096adf3239902\", \"content_unittests\": \"dd5271cce52f631d72d4a0bc7e8e208d43288acb\", \"performance_webview_test_suite\": \"d26636d3e4ca5a43a73a055f3f444305d6be59cb\", \"wtf_unittests\": \"b53996161985bbc0c016533a53e1323c5f1ca2ad\", \"webkit_layout_tests_exparchive\": \"50b68446f440861e27809a93b211259899f6ce94\", \"chrome_cleaner_unittests\": \"3a70292a069d311b499f794c6835fc264488ca79\", \"traffic_annotation_auditor_unittests\": \"2708d2567302359a3d82700e3144f50b02f5cb5b\", \"libjingle_xmpp_unittests\": \"b05108b2abcfdc49c2b9f934a08dce5a2b439bbd\", \"remoting_unittests\": \"ccd78dd798a3d533fca4c432ba2b9df7242d4d92\", \"vr_common_perftests\": \"b0a934bb45ec0a1aedce91cbb5bead1e9568d16b\", \"filesystem_service_unittests\": \"666820f3f897b20e6943cd266b76d613a6ad391f\", \"chrome_elf_import_unittests\": \"fc0cf887e3aaa8e4df2c2913562a132e9cb6ebef\", \"installer_util_unittests\": \"feb80e4a3c674e65593eb313bfecf1151a3797de\", \"gfx_unittests\": \"f6b611f0518111f4dff91f3568368275250aa2c5\", \"headless_browsertests\": \"08f12e8a601dd69fcad8cf98cec85f7a783da27f\", \"capture_unittests\": \"92abcf317f2793f09047fec996487654cd257e5c\", \"chrome_elf_unittests\": \"2f0011e475382a84916e7e5ab5f22d337e7439dc\", \"telemetry_gpu_unittests\": \"08955bd08769ea24effd8c70e18a22765f836549\", \"command_buffer_perftests\": \"868f5b69792482d4fc2c74281051ae31df89a511\", \"media_unittests\": \"5d61e46b37469c6813ceebdb6b31e84dcfd8d64e\", \"chromedriver_unittests\": \"7c96d5662db359ccd6973ed0aa40e5749ae43ed8\", \"views_mus_interactive_ui_tests\": \"4a02acb3291e8efff2710e674536bc8b78f69980\", \"storage_unittests\": \"6266ceb381de8c0d50ea95bdd5d6a3626be79c70\", \"media_service_unittests\": \"cda05f15407ec7fd203738e372be9e2c2647929a\", \"compositor_unittests\": \"024180609bcb165c283dead8de51c283583ab952\", \"latency_unittests\": \"0cbff624c355ec3e14849b9a1a393cdc38726a4e\", \"video_decode_accelerator_unittest\": \"6df8535cb0221ff6c44f20efe676c5320d7d8e1f\", \"swiftshader_unittests\": \"80ea8ffe921225aedafa0c4a5c964e89af3e669e\", \"telemetry_perf_unittests\": \"ca88f124683eff85d2b374b91b6dbc970acd7169\", \"media_blink_unittests\": \"1a995e18ed9ac0e2d6a84b5f63fdb6b3717656d6\", \"views_mus_unittests\": \"9145e0b1f414b71b2eb1bc33993c4a9e60966570\", \"components_unittests\": \"53fd1c613ff86ce89216866eacfbab142a518003\", \"snapshot_unittests\": \"f28760c696e0632319d7f566cdc513582ab7041a\", \"accessibility_unittests\": \"3a81b88dee50c1feaebd3b6da0c5ea44941eb38f\", \"net_perftests\": \"fc958f1f83b60e968b86cd6ca7e2e8725d4adddc\", \"aura_unittests\": \"0a8ed157982703dd10f52e9d8035e16189c427b7\", \"services_unittests\": \"d03b63dd0be744bb2690d911f4234a0aba7c8994\", \"components_perftests\": \"26b9d2eeb1008717e5e7c3831668eb6d21aaa1c3\", \"events_unittests\": \"5674f6404722ae907f44c55f7e43ed1a00742b78\", \"tracing_perftests\": \"5dca39de8d940c7d6d65c15bb0cfb7e3cbfe3713\", \"chromedriver_replay_unittests\": \"e2ec5b5deadfbf1a0e00246e86e8f3e11e9cace0\", \"ui_touch_selection_unittests\": \"fbb784ad36fd97d0a47cea90102be956501b49bb\", \"cacheinvalidation_unittests\": \"35f544cd39355e85d0f656b8111656bf14dbdcff\", \"viz_unittests\": \"38db58ae214c0103d0ce45894bc55fc1eb542411\", \"browser_tests\": \"a9c378e65fe1cc41810fbb743be8d3ce85933273\", \"net_unittests\": \"454e6a34106ddb23342a92eac9b06368db8d7b78\", \"midi_unittests\": \"978b76d0c252acfb2cf35a35c1a39eefd0632bc2\", \"boringssl_ssl_tests\": \"a087de3585d217e18bcc29f88245d6429dfd72d3\", \"sbox_validation_tests\": \"d2d1ce3237739718581478963a0607780f909821\", \"elevation_service_unittests\": \"dc6ea91b808846db40107ca6dc7ab92e30b81706\", \"gpu_unittests\": \"c87798e0f6d16c8339b778869986daf531a720fb\", \"native_theme_unittests\": \"7bd1497d5d163dcb3df63929b245c5a7dce5adf5\", \"interactive_ui_tests\": \"836449d73ddedc0f0194f6e46759a7e5ed35d3c5\", \"mojo_unittests\": \"61dacdd6bfecd5c71cb9c7b1057dcb389116fef1\", \"url_unittests\": \"ac1551a0049ae2e794e36b28017b8857474130d7\", \"media_perftests\": \"1367ba23a65d0597c2c5a336029db15864dd9444\", \"cronet_tests\": \"1a11ffc1af2e503578be20a799b846a440dd27c2\", \"google_apis_unittests\": \"91201e7314ad0ec0e0a2ac2cfc83ca6966b48157\", \"telemetry_gpu_integration_test\": \"1e9af3c287154865b0d81e6459e5cd453aee6357\", \"blink_heap_unittests\": \"03a1e13689acdbdd7858205ee0acec516f4767c0\", \"base_unittests\": \"2c29a0cadbf1d1f8d0f92af0e0a5668ce74687b5\", \"sync_integration_tests\": \"59517f5268b4f7908dd6aed5c97e6ec1ddf69404\", \"sql_unittests\": \"d8f89f698e23195e74d0985aec34edc2397642cf\", \"courgette_unittests\": \"efba834b138eace53c2d53350843301a3f506f0e\", \"blink_fuzzer_unittests\": \"c491e5fd6923590f4fab86a361455700db9290f5\", \"gl_tests\": \"1e05e8eaca5ded742104623d2518e8d38a7b128d\", \"zucchini_unittests\": \"323f07c22a18797ec734e01390dfcff41239a12d\", \"ipc_tests\": \"f4b22c008e3f5c3443d111d4c96a301cd686b60e\", \"angle_end2end_tests\": \"de04e22a3587f2e9a518857e2f40e879b29d3a51\", \"blink_platform_unittests\": \"30875fb35c3ac439cf91f479722e70ab6998256d\", \"components_browsertests\": \"c8eb2e306426e5c1c1ecb46e7d5909855c5620aa\", \"views_perftests\": \"a075447316c8bbe4a79cd3acca26949fe539a937\", \"angle_perftests\": \"62c7e39e2e1ea758a6b0fe96aed6b7d57b0acc5a\", \"display_unittests\": \"a9a60c95a8c3624910daf4c30c2ca7b1e7ec06c7\", \"sbox_unittests\": \"b245459ad2dbd8810573c529993824ad7a2a3418\", \"service_manager_unittests\": \"0204402099799faeec0dd54fa5bc252e8bdcce26\", \"pdf_unittests\": \"1b54efc6e0e56c6176dd6d54b7e580c3f971f890\", \"skia_unittests\": \"399891f0d90d0b4298e8f6aa41c9bdc85b93e797\", \"angle_white_box_tests\": \"f93f612ceb283c0d718c797ccb27bd361aefd6a8\", \"crypto_unittests\": \"14f3652905d9a2f56d6d02d2e0cd78dbdc9718ca\", \"nacl_loader_unittests\": \"6c1469e76c7df4f7d3dbfa449cba96eafed17c26\", \"unit_tests\": \"b01addad40d38728d4bf0033fc8d71642987d4b3\", \"content_browsertests\": \"f4652677aefdf3bc7edec7df6d35229acbb3528d\", \"printing_unittests\": \"5de76a45f92b888a59722b226036866c888c7138\", \"device_unittests\": \"0c1201a9fb8bfad71a996623f090bd482e4d472a\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1536558180040400",
"status": "COMPLETED",
"status_changed_ts": "1536564174340096",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10036",
"builder:Windows deterministic",
"buildset:commit/git/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101225750499050800",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_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/10036",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935795688359718720",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe3ac346a9e30b2bba001db47af1521b417ed92a",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_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/8935795688359718720/+/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:9101225750499050800",
"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:71d843ea58cc76a6b4422ca80f2115179bb30d7f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fdad2a929f83d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1536564174342479",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10036",
"utcnow_ts": "1536564175055565"
}
}
[07:22:55.067] Invocation finished in 1h39m58.926575825s with status SUCCEEDED