[07:56:46.213] New invocation is queued and will start shortly
[07:56:47.541] Starting the invocation (attempt 1)
[07:56:47.573] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:56:47.573] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:56:47.573] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9107015536225334432",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9b4da1b201b2a323e2e898ff777cd89338ef3ee6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9107015536225334432",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"gitiles_ref:refs/heads/master"
]
}
[07:56:48.895] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1531036607670090",
"id": "8941585474033786432",
"lease_expiration_ts": "1531097808643260",
"lease_key": "305866330",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9b4da1b201b2a323e2e898ff777cd89338ef3ee6\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1531036608813450",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9427",
"builder:Windows deterministic",
"buildset:commit/git/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107015536225334432",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"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/9427",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941585474033786432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"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/8941585474033786432/+/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:9107015536225334432",
"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:dfa6096ea25a84c1e3f6fa3a9f293c6aecf802a3",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e91b62f797c5310",
"user_agent:luci-scheduler"
],
"updated_ts": "1531036608813550",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9427",
"utcnow_ts": "1531036608884660"
}
}
[07:56:48.895] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9427
[07:56:48.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:2:0) after 1m0s
[07:57:48.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:2:0)
[07:57:48.916] Timer tick, asking Buildbucket for the build status
[07:57:49.029] Build 8941585474033786432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:49.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:3:0) after 1m0s
[07:58:28.318] Received PubSub notification, asking Buildbucket for the build status
[07:58:28.365] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:49.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:3:0)
[07:58:49.062] Timer tick, asking Buildbucket for the build status
[07:58:49.143] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:49.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:5:0) after 1m0s
[07:59:49.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:5:0)
[07:59:49.160] Timer tick, asking Buildbucket for the build status
[07:59:49.292] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:49.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:6:0) after 1m0s
[08:00:49.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:6:0)
[08:00:49.309] Timer tick, asking Buildbucket for the build status
[08:00:49.450] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:49.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:7:0) after 1m0s
[08:01:49.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:7:0)
[08:01:49.472] Timer tick, asking Buildbucket for the build status
[08:01:49.509] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:49.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:8:0) after 1m0s
[08:02:49.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:8:0)
[08:02:49.642] Timer tick, asking Buildbucket for the build status
[08:02:49.901] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:49.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:9:0) after 1m0s
[08:03:49.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:9:0)
[08:03:49.967] Timer tick, asking Buildbucket for the build status
[08:03:50.029] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:50.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:10:0) after 1m0s
[08:04:50.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:10:0)
[08:04:50.186] Timer tick, asking Buildbucket for the build status
[08:04:50.239] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:50.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:11:0) after 1m0s
[08:05:50.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:11:0)
[08:05:50.369] Timer tick, asking Buildbucket for the build status
[08:05:50.433] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:50.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:12:0) after 1m0s
[08:06:50.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:12:0)
[08:06:50.449] Timer tick, asking Buildbucket for the build status
[08:06:50.606] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:50.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:13:0) after 1m0s
[08:07:50.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:13:0)
[08:07:50.630] Timer tick, asking Buildbucket for the build status
[08:07:50.684] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:50.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:14:0) after 1m0s
[08:08:50.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:14:0)
[08:08:50.705] Timer tick, asking Buildbucket for the build status
[08:08:50.944] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:50.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:15:0) after 1m0s
[08:09:50.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:15:0)
[08:09:50.966] Timer tick, asking Buildbucket for the build status
[08:09:51.061] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:51.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:16:0) after 1m0s
[08:10:51.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:16:0)
[08:10:51.161] Timer tick, asking Buildbucket for the build status
[08:10:51.226] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:51.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:17:0) after 1m0s
[08:11:51.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:17:0)
[08:11:51.246] Timer tick, asking Buildbucket for the build status
[08:11:51.337] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:51.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:18:0) after 1m0s
[08:12:51.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:18:0)
[08:12:51.438] Timer tick, asking Buildbucket for the build status
[08:12:51.471] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:51.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:19:0) after 1m0s
[08:13:51.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:19:0)
[08:13:51.597] Timer tick, asking Buildbucket for the build status
[08:13:51.703] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:51.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:20:0) after 1m0s
[08:14:51.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:20:0)
[08:14:51.846] Timer tick, asking Buildbucket for the build status
[08:14:51.888] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:51.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:21:0) after 1m0s
[08:15:52.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:21:0)
[08:15:52.017] Timer tick, asking Buildbucket for the build status
[08:15:52.171] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:52.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:22:0) after 1m0s
[08:16:52.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:22:0)
[08:16:52.285] Timer tick, asking Buildbucket for the build status
[08:16:52.365] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:52.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:23:0) after 1m0s
[08:17:52.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:23:0)
[08:17:52.446] Timer tick, asking Buildbucket for the build status
[08:17:52.509] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:52.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:24:0) after 1m0s
[08:18:52.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:24:0)
[08:18:52.527] Timer tick, asking Buildbucket for the build status
[08:18:52.586] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:52.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:25:0) after 1m0s
[08:19:52.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:25:0)
[08:19:52.683] Timer tick, asking Buildbucket for the build status
[08:19:52.766] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:52.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:26:0) after 1m0s
[08:20:52.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:26:0)
[08:20:52.784] Timer tick, asking Buildbucket for the build status
[08:20:52.842] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:52.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:27:0) after 1m0s
[08:21:52.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:27:0)
[08:21:52.861] Timer tick, asking Buildbucket for the build status
[08:21:52.905] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:52.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:28:0) after 1m0s
[08:22:52.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:28:0)
[08:22:52.973] Timer tick, asking Buildbucket for the build status
[08:22:53.189] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:53.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:29:0) after 1m0s
[08:23:53.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:29:0)
[08:23:53.208] Timer tick, asking Buildbucket for the build status
[08:23:53.370] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:53.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:30:0) after 1m0s
[08:24:53.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:30:0)
[08:24:53.391] Timer tick, asking Buildbucket for the build status
[08:24:53.556] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:53.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:31:0) after 1m0s
[08:25:53.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:31:0)
[08:25:53.578] Timer tick, asking Buildbucket for the build status
[08:25:53.623] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:53.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:32:0) after 1m0s
[08:26:53.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:32:0)
[08:26:53.643] Timer tick, asking Buildbucket for the build status
[08:26:53.769] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:53.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:33:0) after 1m0s
[08:27:53.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:33:0)
[08:27:53.791] Timer tick, asking Buildbucket for the build status
[08:27:53.825] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:53.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:34:0) after 1m0s
[08:28:53.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:34:0)
[08:28:53.845] Timer tick, asking Buildbucket for the build status
[08:28:53.904] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:53.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:35:0) after 1m0s
[08:29:53.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:35:0)
[08:29:53.930] Timer tick, asking Buildbucket for the build status
[08:29:54.148] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:54.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:36:0) after 1m0s
[08:30:54.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:36:0)
[08:30:54.170] Timer tick, asking Buildbucket for the build status
[08:30:54.453] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:54.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:37:0) after 1m0s
[08:31:54.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:37:0)
[08:31:54.472] Timer tick, asking Buildbucket for the build status
[08:31:54.518] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:54.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:38:0) after 1m0s
[08:32:54.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:38:0)
[08:32:54.538] Timer tick, asking Buildbucket for the build status
[08:32:54.603] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:39:0) after 1m0s
[08:33:54.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:39:0)
[08:33:54.693] Timer tick, asking Buildbucket for the build status
[08:33:54.738] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:54.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:40:0) after 1m0s
[08:34:54.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:40:0)
[08:34:54.759] Timer tick, asking Buildbucket for the build status
[08:34:55.139] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:55.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:41:0) after 1m0s
[08:35:55.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:41:0)
[08:35:55.201] Timer tick, asking Buildbucket for the build status
[08:35:55.334] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:55.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:42:0) after 1m0s
[08:36:55.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:42:0)
[08:36:55.374] Timer tick, asking Buildbucket for the build status
[08:36:55.532] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:55.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:43:0) after 1m0s
[08:37:55.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:43:0)
[08:37:55.554] Timer tick, asking Buildbucket for the build status
[08:37:55.751] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:55.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:44:0) after 1m0s
[08:38:55.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:44:0)
[08:38:55.768] Timer tick, asking Buildbucket for the build status
[08:38:55.810] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:55.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:45:0) after 1m0s
[08:39:55.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:45:0)
[08:39:55.829] Timer tick, asking Buildbucket for the build status
[08:39:56.013] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:56.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:46:0) after 1m0s
[08:40:56.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:46:0)
[08:40:56.035] Timer tick, asking Buildbucket for the build status
[08:40:56.170] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:56.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:47:0) after 1m0s
[08:41:56.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:47:0)
[08:41:56.266] Timer tick, asking Buildbucket for the build status
[08:41:56.365] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:56.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:48:0) after 1m0s
[08:42:56.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:48:0)
[08:42:56.382] Timer tick, asking Buildbucket for the build status
[08:42:56.755] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:56.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:49:0) after 1m0s
[08:43:56.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:49:0)
[08:43:56.777] Timer tick, asking Buildbucket for the build status
[08:43:56.865] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:56.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:50:0) after 1m0s
[08:44:56.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:50:0)
[08:44:56.886] Timer tick, asking Buildbucket for the build status
[08:44:56.962] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:51:0) after 1m0s
[08:45:56.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:51:0)
[08:45:56.981] Timer tick, asking Buildbucket for the build status
[08:45:57.040] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:57.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:52:0) after 1m0s
[08:46:57.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:52:0)
[08:46:57.058] Timer tick, asking Buildbucket for the build status
[08:46:57.241] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:57.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:53:0) after 1m0s
[08:47:57.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:53:0)
[08:47:57.259] Timer tick, asking Buildbucket for the build status
[08:47:57.617] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:57.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:54:0) after 1m0s
[08:48:57.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:54:0)
[08:48:57.635] Timer tick, asking Buildbucket for the build status
[08:48:57.909] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:57.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:55:0) after 1m0s
[08:49:57.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:55:0)
[08:49:57.933] Timer tick, asking Buildbucket for the build status
[08:49:57.975] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:57.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:56:0) after 1m0s
[08:50:58.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:56:0)
[08:50:58.038] Timer tick, asking Buildbucket for the build status
[08:50:58.140] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:58.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:57:0) after 1m0s
[08:51:58.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:57:0)
[08:51:58.169] Timer tick, asking Buildbucket for the build status
[08:51:58.215] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:58.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:58:0) after 1m0s
[08:52:58.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:58:0)
[08:52:58.242] Timer tick, asking Buildbucket for the build status
[08:52:58.299] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:58.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:59:0) after 1m0s
[08:53:58.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:59:0)
[08:53:58.320] Timer tick, asking Buildbucket for the build status
[08:53:58.400] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:58.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:60:0) after 1m0s
[08:54:58.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:60:0)
[08:54:58.419] Timer tick, asking Buildbucket for the build status
[08:54:58.544] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:58.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:61:0) after 1m0s
[08:55:58.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:61:0)
[08:55:58.566] Timer tick, asking Buildbucket for the build status
[08:55:58.625] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:58.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:62:0) after 1m0s
[08:56:58.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:62:0)
[08:56:58.728] Timer tick, asking Buildbucket for the build status
[08:56:58.806] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:58.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:63:0) after 1m0s
[08:57:58.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:63:0)
[08:57:58.840] Timer tick, asking Buildbucket for the build status
[08:57:58.876] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:58.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:64:0) after 1m0s
[08:58:58.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:64:0)
[08:58:58.895] Timer tick, asking Buildbucket for the build status
[08:58:59.014] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:65:0) after 1m0s
[08:59:59.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:65:0)
[08:59:59.112] Timer tick, asking Buildbucket for the build status
[08:59:59.146] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:59.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:66:0) after 1m0s
[09:00:59.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:66:0)
[09:00:59.165] Timer tick, asking Buildbucket for the build status
[09:00:59.936] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:59.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:67:0) after 1m0s
[09:01:59.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:67:0)
[09:01:59.956] Timer tick, asking Buildbucket for the build status
[09:02:00.139] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:00.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:68:0) after 1m0s
[09:03:00.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:68:0)
[09:03:00.160] Timer tick, asking Buildbucket for the build status
[09:03:00.196] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:00.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:69:0) after 1m0s
[09:04:00.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:69:0)
[09:04:00.245] Timer tick, asking Buildbucket for the build status
[09:04:00.313] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:00.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:70:0) after 1m0s
[09:05:00.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:70:0)
[09:05:00.343] Timer tick, asking Buildbucket for the build status
[09:05:00.456] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:00.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:71:0) after 1m0s
[09:06:00.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:71:0)
[09:06:00.503] Timer tick, asking Buildbucket for the build status
[09:06:00.662] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:00.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:72:0) after 1m0s
[09:07:00.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:72:0)
[09:07:00.682] Timer tick, asking Buildbucket for the build status
[09:07:00.858] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:00.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:73:0) after 1m0s
[09:08:00.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:73:0)
[09:08:00.928] Timer tick, asking Buildbucket for the build status
[09:08:01.165] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:01.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:74:0) after 1m0s
[09:09:01.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:74:0)
[09:09:01.199] Timer tick, asking Buildbucket for the build status
[09:09:01.289] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:01.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:75:0) after 1m0s
[09:10:01.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:75:0)
[09:10:01.383] Timer tick, asking Buildbucket for the build status
[09:10:01.602] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:01.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:76:0) after 1m0s
[09:11:01.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:76:0)
[09:11:01.625] Timer tick, asking Buildbucket for the build status
[09:11:01.942] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:01.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:77:0) after 1m0s
[09:12:01.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:77:0)
[09:12:01.970] Timer tick, asking Buildbucket for the build status
[09:12:02.052] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:78:0) after 1m0s
[09:13:02.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:78:0)
[09:13:02.071] Timer tick, asking Buildbucket for the build status
[09:13:02.205] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:02.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:79:0) after 1m0s
[09:14:02.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:79:0)
[09:14:02.285] Timer tick, asking Buildbucket for the build status
[09:14:05.677] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:05.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:80:0) after 1m0s
[09:15:05.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:80:0)
[09:15:05.803] Timer tick, asking Buildbucket for the build status
[09:15:05.873] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:05.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:81:0) after 1m0s
[09:16:05.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:81:0)
[09:16:05.909] Timer tick, asking Buildbucket for the build status
[09:16:05.975] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:05.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:82:0) after 1m0s
[09:17:06.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:82:0)
[09:17:06.010] Timer tick, asking Buildbucket for the build status
[09:17:06.076] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:06.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:83:0) after 1m0s
[09:18:06.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:83:0)
[09:18:06.102] Timer tick, asking Buildbucket for the build status
[09:18:06.272] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:06.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:84:0) after 1m0s
[09:19:06.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:84:0)
[09:19:06.310] Timer tick, asking Buildbucket for the build status
[09:19:06.409] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:06.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:85:0) after 1m0s
[09:20:06.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:85:0)
[09:20:06.440] Timer tick, asking Buildbucket for the build status
[09:20:06.508] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:06.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:86:0) after 1m0s
[09:21:06.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:86:0)
[09:21:06.531] Timer tick, asking Buildbucket for the build status
[09:21:06.640] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:06.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:87:0) after 1m0s
[09:22:06.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:87:0)
[09:22:06.671] Timer tick, asking Buildbucket for the build status
[09:22:06.770] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:06.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:88:0) after 1m0s
[09:23:06.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:88:0)
[09:23:06.794] Timer tick, asking Buildbucket for the build status
[09:23:06.904] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:06.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:89:0) after 1m0s
[09:24:06.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:89:0)
[09:24:06.924] Timer tick, asking Buildbucket for the build status
[09:24:06.990] Build 8941585474033786432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:06.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9107015536225334432:90:0) after 1m0s
[09:24:09.900] Received PubSub notification, asking Buildbucket for the build status
[09:24:10.011] Build 8941585474033786432: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[09:24:10.011] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1531041847537830",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1531036607670090",
"failure_reason": "INFRA_FAILURE",
"id": "8941585474033786432",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9b4da1b201b2a323e2e898ff777cd89338ef3ee6\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\\nFailure Uncaught Exception\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"recipe infra failure: Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\", \"bootstrapperCallStack\": [], \"type\": \"RECIPE_INFRA_FAILURE\"}, \"recipeResult\": {\"failure\": {\"exception\": {\"traceback\": [\"Traceback (most recent call last):\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\run.py\\\", line 287, in _new_run\", \" recipe_result = recipe_script.run(api, self.properties, self.environ)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\loader.py\\\", line 108, in run\", \" self.run_steps, properties, environ, self.PROPERTIES, api=api)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\loader.py\\\", line 636, in invoke_with_properties\", \" arg_names, **additional_args)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\loader.py\\\", line 599, in _invoke_with_properties\", \" return callable_obj(*props, **additional_args)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\build\\\\scripts/slave\\\\recipes\\\\swarming/deterministic_build.py\\\", line 194, in RunSteps\", \" str(api.chromium.output_dir).rstrip('\\\\\\\\/') + '.2')\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\recipe_api.py\\\", line 759, in _inner\", \" return func(*a, **kw)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\build\\\\scripts/slave\\\\recipe_modules\\\\isolate\\\\api.py\\\", line 350, in compare_build_artifacts\", \" self.archive_differences(first_dir, second_dir, step_result.json.output)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\recipe_engine\\\\recipe_engine\\\\recipe_api.py\\\", line 759, in _inner\", \" return func(*a, **kw)\", \" File \\\"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\kitchen-checkout\\\\build\\\\scripts/slave\\\\recipe_modules\\\\isolate\\\\api.py\\\", line 302, in archive_differences\", \" diffs = list(itertools.chain.from_iterable(values.itervalues()))\", \"AttributeError: 'NoneType' object has no attribute 'itervalues'\"]}, \"humanReason\": \"Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8941585474033786432/+/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\": [\"3675-21ffa58\"], \"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\": \"030b88a205c9ce9a82d68798bfaa059fd55216cd\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"9b4da1b201b2a323e2e898ff777cd89338ef3ee6\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23879}\", \"$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@{#573185}\", \"branch\": \"refs/heads/master\", \"revision\": \"9b4da1b201b2a323e2e898ff777cd89338ef3ee6\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"0d405d41bdba864f92d6ce10e80fbf1bc2b9fe89\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"7e585118fe827063e715c3741c3f43c4dd677ec2\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1531036607670090, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/9b4da1b201b2a323e2e898ff777cd89338ef3ee6\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b4da1b201b2a323e2e898ff777cd89338ef3ee6\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9107015536225334432\", \"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\": \"8941585474033786432\"}}, \"got_v8_revision\": \"c7d30add28811721d2eda361b469bc3c7cac67f8\", \"got_v8_revision_cp\": \"refs/heads/6.9.322@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9427, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1531036706857190",
"status": "COMPLETED",
"status_changed_ts": "1531041849229110",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9427",
"builder:Windows deterministic",
"buildset:commit/git/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107015536225334432",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"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/9427",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941585474033786432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b4da1b201b2a323e2e898ff777cd89338ef3ee6",
"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/8941585474033786432/+/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:9107015536225334432",
"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:dfa6096ea25a84c1e3f6fa3a9f293c6aecf802a3",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e91b62f797c5310",
"user_agent:luci-scheduler"
],
"updated_ts": "1531041849231190",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9427",
"utcnow_ts": "1531041849993140"
}
}
[09:24:10.011] Invocation finished in 1h27m23.814533948s with status FAILED