[04:56:44.113] New invocation is queued and will start shortly
[04:56:45.397] Starting the invocation (attempt 1)
[04:56:45.449] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:56:45.449] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:56:45.449] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9086914336508172032",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9086914336508172032",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08",
"gitiles_ref:refs/heads/master"
]
}
[04:56:47.359] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550206605553050",
"id": "8921484274333632592",
"lease_expiration_ts": "1550325407079858",
"lease_key": "319277664",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550206607186982",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/11973",
"builder:Windows deterministic",
"buildset:commit/git/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086914336508172032",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8921484274333632592/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:43085525d4250810",
"user_agent:luci-scheduler"
],
"updated_ts": "1550206607187105",
"url": "https://ci.chromium.org/b/8921484274333632592",
"utcnow_ts": "1550206607347478"
}
}
[04:56:47.359] Task URL: https://ci.chromium.org/b/8921484274333632592
[04:56:47.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:2:0) after 1m0s
[04:57:47.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:2:0)
[04:57:47.376] Timer tick, asking Buildbucket for the build status
[04:57:47.585] Build 8921484274333632592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:47.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:3:0) after 1m0s
[04:58:47.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:3:0)
[04:58:47.602] Timer tick, asking Buildbucket for the build status
[04:58:47.669] Build 8921484274333632592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:47.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:4:0) after 1m0s
[04:59:10.206] Received PubSub notification, asking Buildbucket for the build status
[04:59:10.253] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:47.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:4:0)
[04:59:47.684] Timer tick, asking Buildbucket for the build status
[04:59:47.794] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:47.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:6:0) after 1m0s
[05:00:47.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:6:0)
[05:00:47.816] Timer tick, asking Buildbucket for the build status
[05:00:48.077] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:48.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:7:0) after 1m0s
[05:01:48.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:7:0)
[05:01:48.092] Timer tick, asking Buildbucket for the build status
[05:01:48.198] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:48.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:8:0) after 1m0s
[05:02:48.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:8:0)
[05:02:48.323] Timer tick, asking Buildbucket for the build status
[05:02:48.418] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:48.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:9:0) after 1m0s
[05:03:48.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:9:0)
[05:03:48.434] Timer tick, asking Buildbucket for the build status
[05:03:48.660] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:48.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:10:0) after 1m0s
[05:04:48.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:10:0)
[05:04:48.729] Timer tick, asking Buildbucket for the build status
[05:04:48.973] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:48.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:11:0) after 1m0s
[05:05:48.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:11:0)
[05:05:48.991] Timer tick, asking Buildbucket for the build status
[05:05:49.037] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:49.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:12:0) after 1m0s
[05:06:49.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:12:0)
[05:06:49.053] Timer tick, asking Buildbucket for the build status
[05:06:49.143] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:49.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:13:0) after 1m0s
[05:07:49.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:13:0)
[05:07:49.161] Timer tick, asking Buildbucket for the build status
[05:07:49.209] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:49.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:14:0) after 1m0s
[05:08:49.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:14:0)
[05:08:49.224] Timer tick, asking Buildbucket for the build status
[05:08:49.372] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:49.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:15:0) after 1m0s
[05:09:49.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:15:0)
[05:09:49.389] Timer tick, asking Buildbucket for the build status
[05:09:49.424] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:49.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:16:0) after 1m0s
[05:10:49.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:16:0)
[05:10:49.440] Timer tick, asking Buildbucket for the build status
[05:10:49.770] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:49.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:17:0) after 1m0s
[05:11:49.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:17:0)
[05:11:49.787] Timer tick, asking Buildbucket for the build status
[05:11:49.849] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:49.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:18:0) after 1m0s
[05:12:49.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:18:0)
[05:12:49.908] Timer tick, asking Buildbucket for the build status
[05:12:49.968] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:49.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:19:0) after 1m0s
[05:13:49.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:19:0)
[05:13:49.983] Timer tick, asking Buildbucket for the build status
[05:13:50.064] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:50.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:20:0) after 1m0s
[05:14:50.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:20:0)
[05:14:50.095] Timer tick, asking Buildbucket for the build status
[05:14:50.359] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:50.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:21:0) after 1m0s
[05:15:50.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:21:0)
[05:15:50.380] Timer tick, asking Buildbucket for the build status
[05:15:50.434] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:50.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:22:0) after 1m0s
[05:16:50.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:22:0)
[05:16:50.452] Timer tick, asking Buildbucket for the build status
[05:16:50.659] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:50.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:23:0) after 1m0s
[05:17:50.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:23:0)
[05:17:50.696] Timer tick, asking Buildbucket for the build status
[05:17:50.737] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:50.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:24:0) after 1m0s
[05:18:50.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:24:0)
[05:18:50.753] Timer tick, asking Buildbucket for the build status
[05:18:50.812] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:50.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:25:0) after 1m0s
[05:19:50.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:25:0)
[05:19:50.829] Timer tick, asking Buildbucket for the build status
[05:19:50.871] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:50.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:26:0) after 1m0s
[05:20:50.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:26:0)
[05:20:50.888] Timer tick, asking Buildbucket for the build status
[05:20:50.964] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:50.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:27:0) after 1m0s
[05:21:50.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:27:0)
[05:21:50.995] Timer tick, asking Buildbucket for the build status
[05:21:51.192] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:51.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:28:0) after 1m0s
[05:22:51.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:28:0)
[05:22:51.210] Timer tick, asking Buildbucket for the build status
[05:22:51.298] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:51.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:29:0) after 1m0s
[05:23:51.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:29:0)
[05:23:51.317] Timer tick, asking Buildbucket for the build status
[05:23:51.612] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:51.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:30:0) after 1m0s
[05:24:51.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:30:0)
[05:24:51.634] Timer tick, asking Buildbucket for the build status
[05:24:51.709] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:51.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:31:0) after 1m0s
[05:25:51.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:31:0)
[05:25:51.731] Timer tick, asking Buildbucket for the build status
[05:25:51.783] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:51.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:32:0) after 1m0s
[05:26:51.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:32:0)
[05:26:51.802] Timer tick, asking Buildbucket for the build status
[05:26:51.877] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:51.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:33:0) after 1m0s
[05:27:51.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:33:0)
[05:27:51.895] Timer tick, asking Buildbucket for the build status
[05:27:51.985] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:51.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:34:0) after 1m0s
[05:28:51.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:34:0)
[05:28:51.961] Timer tick, asking Buildbucket for the build status
[05:28:52.134] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:52.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:35:0) after 1m0s
[05:29:52.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:35:0)
[05:29:52.155] Timer tick, asking Buildbucket for the build status
[05:29:52.497] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:52.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:36:0) after 1m0s
[05:30:52.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:36:0)
[05:30:52.516] Timer tick, asking Buildbucket for the build status
[05:30:52.672] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:52.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:37:0) after 1m0s
[05:31:52.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:37:0)
[05:31:52.697] Timer tick, asking Buildbucket for the build status
[05:31:52.807] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:52.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:38:0) after 1m0s
[05:32:52.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:38:0)
[05:32:52.826] Timer tick, asking Buildbucket for the build status
[05:32:52.863] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:52.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:39:0) after 1m0s
[05:33:52.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:39:0)
[05:33:52.969] Timer tick, asking Buildbucket for the build status
[05:33:53.035] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:53.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:40:0) after 1m0s
[05:34:53.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:40:0)
[05:34:53.059] Timer tick, asking Buildbucket for the build status
[05:34:53.155] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:53.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:41:0) after 1m0s
[05:35:53.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:41:0)
[05:35:53.176] Timer tick, asking Buildbucket for the build status
[05:35:53.398] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:53.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:42:0) after 1m0s
[05:36:53.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:42:0)
[05:36:53.414] Timer tick, asking Buildbucket for the build status
[05:36:53.464] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:53.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:43:0) after 1m0s
[05:37:53.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:43:0)
[05:37:53.483] Timer tick, asking Buildbucket for the build status
[05:37:53.580] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:53.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:44:0) after 1m0s
[05:38:53.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:44:0)
[05:38:53.598] Timer tick, asking Buildbucket for the build status
[05:38:53.749] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:53.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:45:0) after 1m0s
[05:39:53.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:45:0)
[05:39:53.775] Timer tick, asking Buildbucket for the build status
[05:39:53.832] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:53.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:46:0) after 1m0s
[05:40:53.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:46:0)
[05:40:53.853] Timer tick, asking Buildbucket for the build status
[05:40:54.099] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:54.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:47:0) after 1m0s
[05:41:54.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:47:0)
[05:41:54.118] Timer tick, asking Buildbucket for the build status
[05:41:54.298] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:48:0) after 1m0s
[05:42:54.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:48:0)
[05:42:54.315] Timer tick, asking Buildbucket for the build status
[05:42:54.396] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:54.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:49:0) after 1m0s
[05:43:54.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:49:0)
[05:43:54.416] Timer tick, asking Buildbucket for the build status
[05:43:54.474] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:54.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:50:0) after 1m0s
[05:44:54.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:50:0)
[05:44:54.492] Timer tick, asking Buildbucket for the build status
[05:44:54.566] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:54.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:51:0) after 1m0s
[05:45:54.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:51:0)
[05:45:54.584] Timer tick, asking Buildbucket for the build status
[05:45:54.656] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:54.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:52:0) after 1m0s
[05:46:54.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:52:0)
[05:46:54.677] Timer tick, asking Buildbucket for the build status
[05:46:54.768] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:54.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:53:0) after 1m0s
[05:47:54.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:53:0)
[05:47:54.790] Timer tick, asking Buildbucket for the build status
[05:47:54.892] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:54.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:54:0) after 1m0s
[05:48:54.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:54:0)
[05:48:54.912] Timer tick, asking Buildbucket for the build status
[05:48:55.048] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:55.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:55:0) after 1m0s
[05:49:55.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:55:0)
[05:49:55.067] Timer tick, asking Buildbucket for the build status
[05:49:55.161] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:55.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:56:0) after 1m0s
[05:50:55.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:56:0)
[05:50:55.202] Timer tick, asking Buildbucket for the build status
[05:50:55.325] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:55.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:57:0) after 1m0s
[05:51:55.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:57:0)
[05:51:55.345] Timer tick, asking Buildbucket for the build status
[05:51:55.469] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:55.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:58:0) after 1m0s
[05:52:55.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:58:0)
[05:52:55.487] Timer tick, asking Buildbucket for the build status
[05:52:55.772] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:55.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:59:0) after 1m0s
[05:53:55.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:59:0)
[05:53:55.788] Timer tick, asking Buildbucket for the build status
[05:53:55.905] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:55.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:60:0) after 1m0s
[05:54:55.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:60:0)
[05:54:55.922] Timer tick, asking Buildbucket for the build status
[05:54:55.967] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:55.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:61:0) after 1m0s
[05:55:55.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:61:0)
[05:55:55.965] Timer tick, asking Buildbucket for the build status
[05:55:56.195] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:56.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:62:0) after 1m0s
[05:56:56.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:62:0)
[05:56:56.296] Timer tick, asking Buildbucket for the build status
[05:56:56.395] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:56.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:63:0) after 1m0s
[05:57:56.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:63:0)
[05:57:56.415] Timer tick, asking Buildbucket for the build status
[05:57:56.541] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:56.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:64:0) after 1m0s
[05:58:56.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:64:0)
[05:58:56.563] Timer tick, asking Buildbucket for the build status
[05:58:56.605] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:56.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:65:0) after 1m0s
[05:59:56.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:65:0)
[05:59:56.626] Timer tick, asking Buildbucket for the build status
[05:59:56.723] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:56.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:66:0) after 1m0s
[06:00:56.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:66:0)
[06:00:56.745] Timer tick, asking Buildbucket for the build status
[06:00:56.990] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:56.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:67:0) after 1m0s
[06:01:57.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:67:0)
[06:01:57.013] Timer tick, asking Buildbucket for the build status
[06:01:57.091] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:57.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:68:0) after 1m0s
[06:02:57.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:68:0)
[06:02:57.109] Timer tick, asking Buildbucket for the build status
[06:02:57.187] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:57.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:69:0) after 1m0s
[06:03:57.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:69:0)
[06:03:57.205] Timer tick, asking Buildbucket for the build status
[06:03:57.255] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:57.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:70:0) after 1m0s
[06:04:57.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:70:0)
[06:04:57.351] Timer tick, asking Buildbucket for the build status
[06:04:57.687] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:57.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:71:0) after 1m0s
[06:05:57.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:71:0)
[06:05:57.704] Timer tick, asking Buildbucket for the build status
[06:05:57.748] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:57.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:72:0) after 1m0s
[06:06:57.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:72:0)
[06:06:57.767] Timer tick, asking Buildbucket for the build status
[06:06:57.822] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:57.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:73:0) after 1m0s
[06:07:57.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:73:0)
[06:07:57.900] Timer tick, asking Buildbucket for the build status
[06:07:57.945] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:57.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:74:0) after 1m0s
[06:08:57.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:74:0)
[06:08:57.992] Timer tick, asking Buildbucket for the build status
[06:08:58.113] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:58.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:75:0) after 1m0s
[06:09:58.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:75:0)
[06:09:58.142] Timer tick, asking Buildbucket for the build status
[06:09:58.284] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:58.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:76:0) after 1m0s
[06:10:58.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:76:0)
[06:10:58.301] Timer tick, asking Buildbucket for the build status
[06:10:58.463] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:58.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:77:0) after 1m0s
[06:11:58.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:77:0)
[06:11:58.494] Timer tick, asking Buildbucket for the build status
[06:11:58.793] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:58.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:78:0) after 1m0s
[06:12:58.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:78:0)
[06:12:58.895] Timer tick, asking Buildbucket for the build status
[06:12:58.940] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:58.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:79:0) after 1m0s
[06:13:58.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:79:0)
[06:13:58.960] Timer tick, asking Buildbucket for the build status
[06:13:59.041] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:59.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:80:0) after 1m0s
[06:14:59.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:80:0)
[06:14:59.059] Timer tick, asking Buildbucket for the build status
[06:14:59.143] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:59.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:81:0) after 1m0s
[06:15:59.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:81:0)
[06:15:59.202] Timer tick, asking Buildbucket for the build status
[06:15:59.461] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:59.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:82:0) after 1m0s
[06:16:59.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:82:0)
[06:16:59.500] Timer tick, asking Buildbucket for the build status
[06:16:59.884] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:59.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:83:0) after 1m0s
[06:17:59.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:83:0)
[06:17:59.906] Timer tick, asking Buildbucket for the build status
[06:17:59.963] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:59.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:84:0) after 1m0s
[06:18:59.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:84:0)
[06:18:59.980] Timer tick, asking Buildbucket for the build status
[06:19:00.080] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:00.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:85:0) after 1m0s
[06:20:00.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:85:0)
[06:20:00.180] Timer tick, asking Buildbucket for the build status
[06:20:00.278] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:00.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:86:0) after 1m0s
[06:21:00.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:86:0)
[06:21:00.305] Timer tick, asking Buildbucket for the build status
[06:21:00.358] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:00.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:87:0) after 1m0s
[06:22:00.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:87:0)
[06:22:00.382] Timer tick, asking Buildbucket for the build status
[06:22:00.427] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:00.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:88:0) after 1m0s
[06:23:00.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:88:0)
[06:23:00.446] Timer tick, asking Buildbucket for the build status
[06:23:00.578] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:00.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:89:0) after 1m0s
[06:24:00.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:89:0)
[06:24:00.598] Timer tick, asking Buildbucket for the build status
[06:24:00.753] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:00.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:90:0) after 1m0s
[06:25:00.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:90:0)
[06:25:00.772] Timer tick, asking Buildbucket for the build status
[06:25:00.844] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:00.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:91:0) after 1m0s
[06:26:00.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:91:0)
[06:26:00.863] Timer tick, asking Buildbucket for the build status
[06:26:01.005] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:01.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:92:0) after 1m0s
[06:27:01.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:92:0)
[06:27:01.095] Timer tick, asking Buildbucket for the build status
[06:27:01.181] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:01.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:93:0) after 1m0s
[06:28:01.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:93:0)
[06:28:01.204] Timer tick, asking Buildbucket for the build status
[06:28:01.274] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:01.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:94:0) after 1m0s
[06:29:01.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:94:0)
[06:29:01.295] Timer tick, asking Buildbucket for the build status
[06:29:01.625] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:01.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:95:0) after 1m0s
[06:30:01.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:95:0)
[06:30:01.648] Timer tick, asking Buildbucket for the build status
[06:30:01.998] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:01.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:96:0) after 1m0s
[06:31:02.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:96:0)
[06:31:02.018] Timer tick, asking Buildbucket for the build status
[06:31:02.066] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:02.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:97:0) after 1m0s
[06:32:02.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:97:0)
[06:32:02.088] Timer tick, asking Buildbucket for the build status
[06:32:02.280] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:02.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:98:0) after 1m0s
[06:33:02.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:98:0)
[06:33:02.311] Timer tick, asking Buildbucket for the build status
[06:33:02.609] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:02.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:99:0) after 1m0s
[06:34:02.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:99:0)
[06:34:02.630] Timer tick, asking Buildbucket for the build status
[06:34:02.740] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:02.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:100:0) after 1m0s
[06:35:02.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:100:0)
[06:35:02.766] Timer tick, asking Buildbucket for the build status
[06:35:02.827] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:02.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:101:0) after 1m0s
[06:36:02.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:101:0)
[06:36:02.846] Timer tick, asking Buildbucket for the build status
[06:36:03.104] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:03.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:102:0) after 1m0s
[06:37:03.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:102:0)
[06:37:03.122] Timer tick, asking Buildbucket for the build status
[06:37:03.183] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:03.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:103:0) after 1m0s
[06:38:03.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:103:0)
[06:38:03.202] Timer tick, asking Buildbucket for the build status
[06:38:03.271] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:03.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:104:0) after 1m0s
[06:39:03.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:104:0)
[06:39:03.292] Timer tick, asking Buildbucket for the build status
[06:39:03.356] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:03.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:105:0) after 1m0s
[06:40:03.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:105:0)
[06:40:03.376] Timer tick, asking Buildbucket for the build status
[06:40:03.416] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:03.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:106:0) after 1m0s
[06:41:03.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:106:0)
[06:41:03.435] Timer tick, asking Buildbucket for the build status
[06:41:03.557] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:03.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:107:0) after 1m0s
[06:42:03.587] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:107:0)
[06:42:03.587] Timer tick, asking Buildbucket for the build status
[06:42:03.633] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:03.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:108:0) after 1m0s
[06:43:03.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:108:0)
[06:43:03.658] Timer tick, asking Buildbucket for the build status
[06:43:03.745] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:03.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:109:0) after 1m0s
[06:44:03.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:109:0)
[06:44:03.768] Timer tick, asking Buildbucket for the build status
[06:44:03.832] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:03.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:110:0) after 1m0s
[06:45:03.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:110:0)
[06:45:03.855] Timer tick, asking Buildbucket for the build status
[06:45:03.900] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:03.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:111:0) after 1m0s
[06:46:03.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:111:0)
[06:46:03.919] Timer tick, asking Buildbucket for the build status
[06:46:03.965] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:03.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:112:0) after 1m0s
[06:47:03.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:112:0)
[06:47:03.986] Timer tick, asking Buildbucket for the build status
[06:47:04.032] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:04.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:113:0) after 1m0s
[06:48:04.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:113:0)
[06:48:04.053] Timer tick, asking Buildbucket for the build status
[06:48:04.117] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:04.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:114:0) after 1m0s
[06:49:04.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:114:0)
[06:49:04.144] Timer tick, asking Buildbucket for the build status
[06:49:04.461] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:04.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:115:0) after 1m0s
[06:50:04.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:115:0)
[06:50:04.486] Timer tick, asking Buildbucket for the build status
[06:50:04.557] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:04.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:116:0) after 1m0s
[06:51:04.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:116:0)
[06:51:04.580] Timer tick, asking Buildbucket for the build status
[06:51:04.730] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:04.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:117:0) after 1m0s
[06:52:04.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:117:0)
[06:52:04.750] Timer tick, asking Buildbucket for the build status
[06:52:04.801] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:04.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:118:0) after 1m0s
[06:53:04.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:118:0)
[06:53:04.822] Timer tick, asking Buildbucket for the build status
[06:53:04.920] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:04.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:119:0) after 1m0s
[06:54:04.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:119:0)
[06:54:04.941] Timer tick, asking Buildbucket for the build status
[06:54:05.003] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:05.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:120:0) after 1m0s
[06:55:05.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:120:0)
[06:55:05.023] Timer tick, asking Buildbucket for the build status
[06:55:05.107] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:05.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:121:0) after 1m0s
[06:56:05.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:121:0)
[06:56:05.128] Timer tick, asking Buildbucket for the build status
[06:56:05.190] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:05.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:122:0) after 1m0s
[06:57:05.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:122:0)
[06:57:05.236] Timer tick, asking Buildbucket for the build status
[06:57:05.284] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:05.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:123:0) after 1m0s
[06:58:05.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:123:0)
[06:58:05.306] Timer tick, asking Buildbucket for the build status
[06:58:05.377] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:05.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:124:0) after 1m0s
[06:59:05.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:124:0)
[06:59:05.397] Timer tick, asking Buildbucket for the build status
[06:59:05.443] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:05.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:125:0) after 1m0s
[07:00:05.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:125:0)
[07:00:05.462] Timer tick, asking Buildbucket for the build status
[07:00:05.509] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:05.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:126:0) after 1m0s
[07:01:05.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:126:0)
[07:01:05.529] Timer tick, asking Buildbucket for the build status
[07:01:05.711] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:05.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:127:0) after 1m0s
[07:02:05.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:127:0)
[07:02:05.730] Timer tick, asking Buildbucket for the build status
[07:02:05.772] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:05.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:128:0) after 1m0s
[07:03:05.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:128:0)
[07:03:05.795] Timer tick, asking Buildbucket for the build status
[07:03:06.254] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:06.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:129:0) after 1m0s
[07:04:06.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:129:0)
[07:04:06.293] Timer tick, asking Buildbucket for the build status
[07:04:06.357] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:06.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:130:0) after 1m0s
[07:05:06.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:130:0)
[07:05:06.379] Timer tick, asking Buildbucket for the build status
[07:05:06.540] Build 8921484274333632592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:06.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9086914336508172032:131:0) after 1m0s
[07:05:43.811] Received PubSub notification, asking Buildbucket for the build status
[07:05:43.848] Build 8921484274333632592: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:05:43.848] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1550214342666508",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550206605553050",
"failure_reason": "BUILD_FAILURE",
"id": "8921484274333632592",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"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\": [\"4105-f0295a3\"], \"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\"]}}, \"ui\": {\"info\": \"Failure compare_build_artifacts\"}, \"properties\": {\"got_nacl_revision\": \"908d9f47b1b2d9027ad421d4c7e4c55c96532deb\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"4dec7371a221faf30d037a6bca0618cb94ca4210\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26691}\", \"$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@{#632506}\", \"branch\": \"refs/heads/master\", \"revision\": \"e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d036c6582e130eb558ac12b56ea2d86909100f6e\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"4b6549824faa1f65b4fe64d29ddf0383405bec32\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550206605553050, \"tags\": [\"build_address:luci.chromium.ci/Windows deterministic/11973\", \"builder:Windows deterministic\", \"buildset:commit/git/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086914336508172032\", \"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\": \"8921484274333632592\"}}, \"got_v8_revision\": \"131559db57560c97c11d6f6c0239f31ac55dbaf0\", \"got_v8_revision_cp\": \"refs/heads/7.4.173@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 11973, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"Windows deterministic\", \"key\": \"builder\"}, {\"value\": \"commit/git/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/chromium.googlesource.com/chromium/src/+/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\", \"key\": \"buildset\"}, {\"value\": \"9086914336508172032\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"chromium/Windows deterministic\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"chromium\", \"builder\": \"Windows deterministic\", \"bucket\": \"ci\"}, \"number\": 11973, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"85e01437f26ff37dc358ef303d841313756fe1f8\", \"canary\": true}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8921484274333632592\", \"input\": {\"gitilesCommit\": {\"project\": \"chromium/src\", \"host\": \"chromium.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"e7cb40987180a2406a6cb483ac1bd2b5db0e7c08\"}}, \"createTime\": \"2019-02-15T04:56:45.553050Z\"}}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1550206749487910",
"status": "COMPLETED",
"status_changed_ts": "1550214343479073",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/11973",
"builder:Windows deterministic",
"buildset:commit/git/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7cb40987180a2406a6cb483ac1bd2b5db0e7c08",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086914336508172032",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8921484274333632592/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:43085525d4250810",
"user_agent:luci-scheduler"
],
"updated_ts": "1550214343480553",
"url": "https://ci.chromium.org/b/8921484274333632592",
"utcnow_ts": "1550214343839999"
}
}
[07:05:43.848] Invocation finished in 2h8m59.752000996s with status FAILED