[06:03:48.113] New invocation is queued and will start shortly
[06:03:49.300] Starting the invocation (attempt 1)
[06:03:49.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:03:49.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:03:49.337] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9093523695585251536",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e2f59f49da06e49c476bd0d32913d7349d61a0d4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9093523695585251536",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"gitiles_ref:refs/heads/master"
]
}
[06:03:50.606] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1543903429429094",
"id": "8928093633541685712",
"lease_expiration_ts": "1544022230305836",
"lease_key": "1168150006",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e2f59f49da06e49c476bd0d32913d7349d61a0d4\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1543903430425900",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10953",
"builder:Windows deterministic",
"buildset:commit/git/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9093523695585251536",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10953",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8928093633541685712",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:2f19301aebbc779351dc95ab1dc03603fa761240",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8928093633541685712/+/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:9093523695585251536",
"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:730145e9e1d37101d0f6001b294c592ab5c2023e",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4190a24dda0a7d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1543903430425967",
"url": "https://ci.chromium.org/b/8928093633541685712",
"utcnow_ts": "1543903430565535"
}
}
[06:03:50.606] Task URL: https://ci.chromium.org/b/8928093633541685712
[06:03:50.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:2:0) after 1m0s
[06:04:50.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:2:0)
[06:04:50.622] Timer tick, asking Buildbucket for the build status
[06:04:50.804] Build 8928093633541685712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:50.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:3:0) after 1m0s
[06:05:48.878] Received PubSub notification, asking Buildbucket for the build status
[06:05:48.927] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:50.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:3:0)
[06:05:50.881] Timer tick, asking Buildbucket for the build status
[06:05:50.917] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:50.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:5:0) after 1m0s
[06:06:50.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:5:0)
[06:06:50.938] Timer tick, asking Buildbucket for the build status
[06:06:51.003] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:51.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:6:0) after 1m0s
[06:07:51.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:6:0)
[06:07:51.019] Timer tick, asking Buildbucket for the build status
[06:07:51.073] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:51.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:7:0) after 1m0s
[06:08:51.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:7:0)
[06:08:51.096] Timer tick, asking Buildbucket for the build status
[06:08:51.131] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:51.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:8:0) after 1m0s
[06:09:51.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:8:0)
[06:09:51.148] Timer tick, asking Buildbucket for the build status
[06:09:51.267] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:51.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:9:0) after 1m0s
[06:10:51.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:9:0)
[06:10:51.289] Timer tick, asking Buildbucket for the build status
[06:10:51.376] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:51.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:10:0) after 1m0s
[06:11:51.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:10:0)
[06:11:51.396] Timer tick, asking Buildbucket for the build status
[06:11:51.448] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:11:0) after 1m0s
[06:12:51.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:11:0)
[06:12:51.463] Timer tick, asking Buildbucket for the build status
[06:12:51.557] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:51.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:12:0) after 1m0s
[06:13:55.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:12:0)
[06:13:55.042] Timer tick, asking Buildbucket for the build status
[06:13:55.119] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:55.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:13:0) after 1m0s
[06:14:55.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:13:0)
[06:14:55.138] Timer tick, asking Buildbucket for the build status
[06:14:55.243] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:55.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:14:0) after 1m0s
[06:15:55.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:14:0)
[06:15:55.273] Timer tick, asking Buildbucket for the build status
[06:15:55.335] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:55.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:15:0) after 1m0s
[06:16:55.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:15:0)
[06:16:55.361] Timer tick, asking Buildbucket for the build status
[06:16:55.520] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:55.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:16:0) after 1m0s
[06:17:55.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:16:0)
[06:17:55.554] Timer tick, asking Buildbucket for the build status
[06:17:55.604] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:55.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:17:0) after 1m0s
[06:18:55.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:17:0)
[06:18:55.660] Timer tick, asking Buildbucket for the build status
[06:18:55.727] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:55.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:18:0) after 1m0s
[06:19:55.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:18:0)
[06:19:55.834] Timer tick, asking Buildbucket for the build status
[06:19:55.942] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:55.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:19:0) after 1m0s
[06:20:55.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:19:0)
[06:20:55.999] Timer tick, asking Buildbucket for the build status
[06:20:56.163] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:56.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:20:0) after 1m0s
[06:21:56.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:20:0)
[06:21:56.191] Timer tick, asking Buildbucket for the build status
[06:21:56.241] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:56.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:21:0) after 1m0s
[06:22:56.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:21:0)
[06:22:56.298] Timer tick, asking Buildbucket for the build status
[06:22:56.386] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:56.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:22:0) after 1m0s
[06:23:56.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:22:0)
[06:23:56.404] Timer tick, asking Buildbucket for the build status
[06:23:56.438] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:56.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:23:0) after 1m0s
[06:24:56.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:23:0)
[06:24:56.462] Timer tick, asking Buildbucket for the build status
[06:24:56.548] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:56.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:24:0) after 1m0s
[06:25:56.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:24:0)
[06:25:56.568] Timer tick, asking Buildbucket for the build status
[06:25:56.625] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:56.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:25:0) after 1m0s
[06:26:56.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:25:0)
[06:26:56.761] Timer tick, asking Buildbucket for the build status
[06:26:56.846] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:26:0) after 1m0s
[06:27:56.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:26:0)
[06:27:56.970] Timer tick, asking Buildbucket for the build status
[06:27:57.084] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:57.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:27:0) after 1m0s
[06:28:57.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:27:0)
[06:28:57.105] Timer tick, asking Buildbucket for the build status
[06:28:57.157] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:57.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:28:0) after 1m0s
[06:29:57.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:28:0)
[06:29:57.181] Timer tick, asking Buildbucket for the build status
[06:29:57.233] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:57.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:29:0) after 1m0s
[06:30:57.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:29:0)
[06:30:57.265] Timer tick, asking Buildbucket for the build status
[06:30:57.391] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:57.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:30:0) after 1m0s
[06:31:57.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:30:0)
[06:31:57.505] Timer tick, asking Buildbucket for the build status
[06:31:57.567] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:57.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:31:0) after 1m0s
[06:32:57.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:31:0)
[06:32:57.588] Timer tick, asking Buildbucket for the build status
[06:32:57.641] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:57.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:32:0) after 1m0s
[06:33:57.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:32:0)
[06:33:57.668] Timer tick, asking Buildbucket for the build status
[06:33:57.726] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:57.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:33:0) after 1m0s
[06:34:57.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:33:0)
[06:34:57.745] Timer tick, asking Buildbucket for the build status
[06:34:58.033] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:58.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:34:0) after 1m0s
[06:35:58.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:34:0)
[06:35:58.062] Timer tick, asking Buildbucket for the build status
[06:35:58.147] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:58.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:35:0) after 1m0s
[06:36:58.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:35:0)
[06:36:58.206] Timer tick, asking Buildbucket for the build status
[06:36:58.268] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:58.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:36:0) after 1m0s
[06:37:58.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:36:0)
[06:37:58.400] Timer tick, asking Buildbucket for the build status
[06:37:58.515] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:58.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:37:0) after 1m0s
[06:38:58.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:37:0)
[06:38:58.542] Timer tick, asking Buildbucket for the build status
[06:38:58.628] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:58.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:38:0) after 1m0s
[06:39:58.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:38:0)
[06:39:58.645] Timer tick, asking Buildbucket for the build status
[06:39:58.694] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:58.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:39:0) after 1m0s
[06:40:58.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:39:0)
[06:40:58.713] Timer tick, asking Buildbucket for the build status
[06:40:58.761] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:58.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:40:0) after 1m0s
[06:41:58.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:40:0)
[06:41:58.793] Timer tick, asking Buildbucket for the build status
[06:41:58.847] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:58.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:41:0) after 1m0s
[06:42:58.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:41:0)
[06:42:58.869] Timer tick, asking Buildbucket for the build status
[06:42:58.926] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:58.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:42:0) after 1m0s
[06:43:58.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:42:0)
[06:43:58.943] Timer tick, asking Buildbucket for the build status
[06:43:58.999] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:43:0) after 1m0s
[06:44:59.020] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:43:0)
[06:44:59.020] Timer tick, asking Buildbucket for the build status
[06:44:59.074] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:59.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:44:0) after 1m0s
[06:45:59.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:44:0)
[06:45:59.095] Timer tick, asking Buildbucket for the build status
[06:45:59.241] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:59.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:45:0) after 1m0s
[06:46:59.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:45:0)
[06:46:59.262] Timer tick, asking Buildbucket for the build status
[06:46:59.405] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:59.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:46:0) after 1m0s
[06:47:59.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:46:0)
[06:47:59.424] Timer tick, asking Buildbucket for the build status
[06:47:59.608] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:59.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:47:0) after 1m0s
[06:48:59.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:47:0)
[06:48:59.625] Timer tick, asking Buildbucket for the build status
[06:48:59.683] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:59.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:48:0) after 1m0s
[06:49:59.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:48:0)
[06:49:59.703] Timer tick, asking Buildbucket for the build status
[06:49:59.820] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:59.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:49:0) after 1m0s
[06:50:59.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:49:0)
[06:50:59.838] Timer tick, asking Buildbucket for the build status
[06:51:00.110] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:00.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:50:0) after 1m0s
[06:52:00.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:50:0)
[06:52:00.188] Timer tick, asking Buildbucket for the build status
[06:52:00.371] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:00.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:51:0) after 1m0s
[06:53:00.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:51:0)
[06:53:00.390] Timer tick, asking Buildbucket for the build status
[06:53:00.461] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:00.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:52:0) after 1m0s
[06:54:00.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:52:0)
[06:54:00.491] Timer tick, asking Buildbucket for the build status
[06:54:00.542] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:00.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:53:0) after 1m0s
[06:55:00.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:53:0)
[06:55:00.573] Timer tick, asking Buildbucket for the build status
[06:55:00.695] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:00.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:54:0) after 1m0s
[06:56:00.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:54:0)
[06:56:00.779] Timer tick, asking Buildbucket for the build status
[06:56:00.844] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:00.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:55:0) after 1m0s
[06:57:00.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:55:0)
[06:57:00.863] Timer tick, asking Buildbucket for the build status
[06:57:00.945] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:00.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:56:0) after 1m0s
[06:58:00.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:56:0)
[06:58:00.964] Timer tick, asking Buildbucket for the build status
[06:58:01.054] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:01.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:57:0) after 1m0s
[06:59:01.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:57:0)
[06:59:01.074] Timer tick, asking Buildbucket for the build status
[06:59:01.121] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:01.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:58:0) after 1m0s
[07:00:01.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:58:0)
[07:00:01.252] Timer tick, asking Buildbucket for the build status
[07:00:01.364] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:01.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:59:0) after 1m0s
[07:01:01.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:59:0)
[07:01:01.406] Timer tick, asking Buildbucket for the build status
[07:01:01.479] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:01.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:60:0) after 1m0s
[07:02:01.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:60:0)
[07:02:01.531] Timer tick, asking Buildbucket for the build status
[07:02:01.563] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:01.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:61:0) after 1m0s
[07:03:01.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:61:0)
[07:03:01.709] Timer tick, asking Buildbucket for the build status
[07:03:01.837] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:01.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:62:0) after 1m0s
[07:04:01.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:62:0)
[07:04:01.870] Timer tick, asking Buildbucket for the build status
[07:04:01.924] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:01.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:63:0) after 1m0s
[07:05:01.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:63:0)
[07:05:01.971] Timer tick, asking Buildbucket for the build status
[07:05:02.030] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:02.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:64:0) after 1m0s
[07:06:02.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:64:0)
[07:06:02.051] Timer tick, asking Buildbucket for the build status
[07:06:02.109] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:02.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:65:0) after 1m0s
[07:07:02.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:65:0)
[07:07:02.222] Timer tick, asking Buildbucket for the build status
[07:07:02.396] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:02.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:66:0) after 1m0s
[07:08:02.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:66:0)
[07:08:02.421] Timer tick, asking Buildbucket for the build status
[07:08:02.545] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:02.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:67:0) after 1m0s
[07:09:02.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:67:0)
[07:09:02.653] Timer tick, asking Buildbucket for the build status
[07:09:02.703] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:02.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:68:0) after 1m0s
[07:10:02.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:68:0)
[07:10:02.723] Timer tick, asking Buildbucket for the build status
[07:10:02.788] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:02.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:69:0) after 1m0s
[07:11:02.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:69:0)
[07:11:02.808] Timer tick, asking Buildbucket for the build status
[07:11:02.870] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:02.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:70:0) after 1m0s
[07:12:02.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:70:0)
[07:12:02.891] Timer tick, asking Buildbucket for the build status
[07:12:02.924] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:02.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:71:0) after 1m0s
[07:13:02.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:71:0)
[07:13:02.946] Timer tick, asking Buildbucket for the build status
[07:13:03.004] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:03.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:72:0) after 1m0s
[07:14:03.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:72:0)
[07:14:03.025] Timer tick, asking Buildbucket for the build status
[07:14:03.102] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:03.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:73:0) after 1m0s
[07:15:03.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:73:0)
[07:15:03.122] Timer tick, asking Buildbucket for the build status
[07:15:03.159] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:03.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:74:0) after 1m0s
[07:16:03.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:74:0)
[07:16:03.180] Timer tick, asking Buildbucket for the build status
[07:16:03.234] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:03.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:75:0) after 1m0s
[07:17:03.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:75:0)
[07:17:03.260] Timer tick, asking Buildbucket for the build status
[07:17:03.313] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:03.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:76:0) after 1m0s
[07:18:03.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:76:0)
[07:18:03.397] Timer tick, asking Buildbucket for the build status
[07:18:03.450] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:03.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:77:0) after 1m0s
[07:19:03.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:77:0)
[07:19:03.475] Timer tick, asking Buildbucket for the build status
[07:19:03.528] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:03.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:78:0) after 1m0s
[07:20:03.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:78:0)
[07:20:03.547] Timer tick, asking Buildbucket for the build status
[07:20:03.609] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:03.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:79:0) after 1m0s
[07:21:03.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:79:0)
[07:21:03.635] Timer tick, asking Buildbucket for the build status
[07:21:03.990] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:03.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:80:0) after 1m0s
[07:22:04.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:80:0)
[07:22:04.014] Timer tick, asking Buildbucket for the build status
[07:22:04.124] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:04.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:81:0) after 1m0s
[07:23:04.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:81:0)
[07:23:04.314] Timer tick, asking Buildbucket for the build status
[07:23:04.386] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:04.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:82:0) after 1m0s
[07:24:04.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:82:0)
[07:24:04.422] Timer tick, asking Buildbucket for the build status
[07:24:04.485] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:04.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:83:0) after 1m0s
[07:25:04.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:83:0)
[07:25:04.506] Timer tick, asking Buildbucket for the build status
[07:25:04.600] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:04.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:84:0) after 1m0s
[07:26:04.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:84:0)
[07:26:04.683] Timer tick, asking Buildbucket for the build status
[07:26:04.753] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:04.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:85:0) after 1m0s
[07:27:04.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:85:0)
[07:27:04.774] Timer tick, asking Buildbucket for the build status
[07:27:04.909] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:04.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:86:0) after 1m0s
[07:28:05.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:86:0)
[07:28:05.043] Timer tick, asking Buildbucket for the build status
[07:28:05.072] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:05.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:87:0) after 1m0s
[07:29:05.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:87:0)
[07:29:05.098] Timer tick, asking Buildbucket for the build status
[07:29:05.132] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:05.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:88:0) after 1m0s
[07:30:05.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:88:0)
[07:30:05.151] Timer tick, asking Buildbucket for the build status
[07:30:05.205] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:05.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:89:0) after 1m0s
[07:31:05.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:89:0)
[07:31:05.229] Timer tick, asking Buildbucket for the build status
[07:31:05.286] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:05.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:90:0) after 1m0s
[07:32:05.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:90:0)
[07:32:05.304] Timer tick, asking Buildbucket for the build status
[07:32:05.356] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:05.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:91:0) after 1m0s
[07:33:05.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:91:0)
[07:33:05.392] Timer tick, asking Buildbucket for the build status
[07:33:05.482] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:05.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:92:0) after 1m0s
[07:34:05.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:92:0)
[07:34:05.501] Timer tick, asking Buildbucket for the build status
[07:34:05.621] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:05.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:93:0) after 1m0s
[07:35:05.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:93:0)
[07:35:05.648] Timer tick, asking Buildbucket for the build status
[07:35:05.715] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:05.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:94:0) after 1m0s
[07:36:05.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:94:0)
[07:36:05.735] Timer tick, asking Buildbucket for the build status
[07:36:05.838] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:05.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:95:0) after 1m0s
[07:37:05.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:95:0)
[07:37:05.857] Timer tick, asking Buildbucket for the build status
[07:37:05.891] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:05.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:96:0) after 1m0s
[07:38:05.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:96:0)
[07:38:05.927] Timer tick, asking Buildbucket for the build status
[07:38:06.035] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:97:0) after 1m0s
[07:39:06.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:97:0)
[07:39:06.063] Timer tick, asking Buildbucket for the build status
[07:39:06.140] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:06.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:98:0) after 1m0s
[07:40:06.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:98:0)
[07:40:06.176] Timer tick, asking Buildbucket for the build status
[07:40:06.294] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:06.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:99:0) after 1m0s
[07:41:06.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:99:0)
[07:41:06.369] Timer tick, asking Buildbucket for the build status
[07:41:06.405] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:06.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:100:0) after 1m0s
[07:42:06.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:100:0)
[07:42:06.487] Timer tick, asking Buildbucket for the build status
[07:42:06.522] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:101:0) after 1m0s
[07:43:06.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:101:0)
[07:43:06.542] Timer tick, asking Buildbucket for the build status
[07:43:06.612] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:06.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:102:0) after 1m0s
[07:44:06.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:102:0)
[07:44:06.696] Timer tick, asking Buildbucket for the build status
[07:44:06.756] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:06.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:103:0) after 1m0s
[07:45:06.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:103:0)
[07:45:06.777] Timer tick, asking Buildbucket for the build status
[07:45:06.844] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:06.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:104:0) after 1m0s
[07:46:06.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:104:0)
[07:46:06.864] Timer tick, asking Buildbucket for the build status
[07:46:06.972] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:06.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:105:0) after 1m0s
[07:47:06.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:105:0)
[07:47:06.996] Timer tick, asking Buildbucket for the build status
[07:47:07.118] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:07.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:106:0) after 1m0s
[07:48:07.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:106:0)
[07:48:07.140] Timer tick, asking Buildbucket for the build status
[07:48:07.196] Build 8928093633541685712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:07.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9093523695585251536:107:0) after 1m0s
[07:48:49.248] Received PubSub notification, asking Buildbucket for the build status
[07:48:49.283] Build 8928093633541685712: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:48:49.283] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1543909728423078",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1543903429429094",
"failure_reason": "BUILD_FAILURE",
"id": "8928093633541685712",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e2f59f49da06e49c476bd0d32913d7349d61a0d4\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"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\"], \"id\": [\"swarm2173-c4\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3901-0f56bf6\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"277022e0e51ae646448daf2d36a81502b8ac53b7\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"e2f59f49da06e49c476bd0d32913d7349d61a0d4\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"f0b761f116f663dbe344d70a785219af49f537d5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25884}\", \"$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@{#613444}\", \"branch\": \"refs/heads/master\", \"revision\": \"e2f59f49da06e49c476bd0d32913d7349d61a0d4\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d0b69a8c50f435139681c817fc2119d7a2575a45\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"e3e680ca47dc179a291915e6396b5616e9113c8a\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1543903429429094, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/e2f59f49da06e49c476bd0d32913d7349d61a0d4\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2f59f49da06e49c476bd0d32913d7349d61a0d4\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9093523695585251536\", \"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\": \"8928093633541685712\"}}, \"got_v8_revision\": \"2f64de8f96923455d55f6bfda9da06eb1c7e8a9f\", \"got_v8_revision_cp\": \"refs/heads/7.3.10@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10953, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"04161ec8d7c781e4498c699254c69ba0dd959fde\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1543903548377034",
"status": "COMPLETED",
"status_changed_ts": "1543909729030315",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10953",
"builder:Windows deterministic",
"buildset:commit/git/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9093523695585251536",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10953",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8928093633541685712",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:2f19301aebbc779351dc95ab1dc03603fa761240",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e2f59f49da06e49c476bd0d32913d7349d61a0d4",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8928093633541685712/+/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:9093523695585251536",
"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:730145e9e1d37101d0f6001b294c592ab5c2023e",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4190a24dda0a7d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1543909729031752",
"url": "https://ci.chromium.org/b/8928093633541685712",
"utcnow_ts": "1543909729272888"
}
}
[07:48:49.283] Invocation finished in 1h45m1.186379502s with status FAILED