[04:28:46.112] New invocation is queued and will start shortly
[04:28:47.260] Starting the invocation (attempt 1)
[04:28:47.300] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:28:47.300] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:28:47.300] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9084651171860231040",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"7d74603acc17e17f8eb37151de6b5afeabf4ae5d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9084651171860231040",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/7d74603acc17e17f8eb37151de6b5afeabf4ae5d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d74603acc17e17f8eb37151de6b5afeabf4ae5d",
"gitiles_ref:refs/heads/master"
]
}
[04:28:49.091] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552364927401432",
"id": "8919221109843367344",
"lease_expiration_ts": "1552483728505962",
"lease_key": "1962181241",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7d74603acc17e17f8eb37151de6b5afeabf4ae5d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552364928942001",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12393",
"builder:Windows deterministic",
"buildset:commit/git/7d74603acc17e17f8eb37151de6b5afeabf4ae5d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d74603acc17e17f8eb37151de6b5afeabf4ae5d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084651171860231040",
"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/8919221109843367344/+/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:4388fa83972a0510",
"user_agent:luci-scheduler"
],
"updated_ts": "1552364928942544",
"url": "https://ci.chromium.org/b/8919221109843367344",
"utcnow_ts": "1552364929078538"
}
}
[04:28:49.091] Task URL: https://ci.chromium.org/b/8919221109843367344
[04:28:49.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:2:0) after 1m0s
[04:28:50.033] Received PubSub notification, asking Buildbucket for the build status
[04:28:50.214] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:49.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:2:0)
[04:29:49.098] Timer tick, asking Buildbucket for the build status
[04:29:49.154] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:49.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:4:0) after 1m0s
[04:30:49.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:4:0)
[04:30:49.174] Timer tick, asking Buildbucket for the build status
[04:30:49.304] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:49.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:5:0) after 1m0s
[04:31:49.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:5:0)
[04:31:49.323] Timer tick, asking Buildbucket for the build status
[04:31:49.379] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:49.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:6:0) after 1m0s
[04:32:49.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:6:0)
[04:32:49.431] Timer tick, asking Buildbucket for the build status
[04:32:49.554] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:49.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:7:0) after 1m0s
[04:33:49.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:7:0)
[04:33:49.570] Timer tick, asking Buildbucket for the build status
[04:33:49.664] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:49.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:8:0) after 1m0s
[04:34:49.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:8:0)
[04:34:49.682] Timer tick, asking Buildbucket for the build status
[04:34:49.720] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:9:0) after 1m0s
[04:35:49.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:9:0)
[04:35:49.740] Timer tick, asking Buildbucket for the build status
[04:35:49.803] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:49.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:10:0) after 1m0s
[04:36:49.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:10:0)
[04:36:49.795] Timer tick, asking Buildbucket for the build status
[04:36:49.834] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:49.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:11:0) after 1m0s
[04:37:49.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:11:0)
[04:37:49.858] Timer tick, asking Buildbucket for the build status
[04:37:49.987] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:49.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:12:0) after 1m0s
[04:38:49.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:12:0)
[04:38:49.976] Timer tick, asking Buildbucket for the build status
[04:38:50.076] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:50.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:13:0) after 1m0s
[04:39:50.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:13:0)
[04:39:50.094] Timer tick, asking Buildbucket for the build status
[04:39:50.260] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:50.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:14:0) after 1m0s
[04:40:50.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:14:0)
[04:40:50.278] Timer tick, asking Buildbucket for the build status
[04:40:50.493] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:50.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:15:0) after 1m0s
[04:41:50.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:15:0)
[04:41:50.513] Timer tick, asking Buildbucket for the build status
[04:41:50.603] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:50.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:16:0) after 1m0s
[04:42:50.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:16:0)
[04:42:50.607] Timer tick, asking Buildbucket for the build status
[04:42:50.715] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:50.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:17:0) after 1m0s
[04:43:50.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:17:0)
[04:43:50.706] Timer tick, asking Buildbucket for the build status
[04:43:50.788] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:50.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:18:0) after 1m0s
[04:44:50.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:18:0)
[04:44:50.853] Timer tick, asking Buildbucket for the build status
[04:44:50.888] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:50.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:19:0) after 1m0s
[04:45:50.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:19:0)
[04:45:50.875] Timer tick, asking Buildbucket for the build status
[04:45:50.983] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:50.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:20:0) after 1m0s
[04:46:50.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:20:0)
[04:46:50.962] Timer tick, asking Buildbucket for the build status
[04:46:51.036] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:51.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:21:0) after 1m0s
[04:47:51.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:21:0)
[04:47:51.026] Timer tick, asking Buildbucket for the build status
[04:47:51.086] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:51.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:22:0) after 1m0s
[04:48:51.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:22:0)
[04:48:51.102] Timer tick, asking Buildbucket for the build status
[04:48:51.172] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:51.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:23:0) after 1m0s
[04:49:51.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:23:0)
[04:49:51.162] Timer tick, asking Buildbucket for the build status
[04:49:51.200] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:24:0) after 1m0s
[04:50:51.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:24:0)
[04:50:51.218] Timer tick, asking Buildbucket for the build status
[04:50:51.279] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:51.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:25:0) after 1m0s
[04:51:51.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:25:0)
[04:51:51.299] Timer tick, asking Buildbucket for the build status
[04:51:51.362] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:51.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:26:0) after 1m0s
[04:52:51.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:26:0)
[04:52:51.382] Timer tick, asking Buildbucket for the build status
[04:52:51.482] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:51.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:27:0) after 1m0s
[04:53:51.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:27:0)
[04:53:51.501] Timer tick, asking Buildbucket for the build status
[04:53:51.551] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:51.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:28:0) after 1m0s
[04:54:51.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:28:0)
[04:54:51.570] Timer tick, asking Buildbucket for the build status
[04:54:51.706] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:51.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:29:0) after 1m0s
[04:55:51.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:29:0)
[04:55:51.714] Timer tick, asking Buildbucket for the build status
[04:55:51.751] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:51.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:30:0) after 1m0s
[04:56:51.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:30:0)
[04:56:51.755] Timer tick, asking Buildbucket for the build status
[04:56:51.832] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:51.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:31:0) after 1m0s
[04:57:51.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:31:0)
[04:57:51.850] Timer tick, asking Buildbucket for the build status
[04:57:51.976] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:51.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:32:0) after 1m0s
[04:58:51.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:32:0)
[04:58:51.997] Timer tick, asking Buildbucket for the build status
[04:58:52.094] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:52.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:33:0) after 1m0s
[04:59:52.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:33:0)
[04:59:52.087] Timer tick, asking Buildbucket for the build status
[04:59:52.159] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:52.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:34:0) after 1m0s
[05:00:52.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:34:0)
[05:00:52.158] Timer tick, asking Buildbucket for the build status
[05:00:52.211] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:52.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:35:0) after 1m0s
[05:01:52.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:35:0)
[05:01:52.233] Timer tick, asking Buildbucket for the build status
[05:01:52.414] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:52.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:36:0) after 1m0s
[05:02:52.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:36:0)
[05:02:52.423] Timer tick, asking Buildbucket for the build status
[05:02:52.503] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:52.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:37:0) after 1m0s
[05:03:52.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:37:0)
[05:03:52.525] Timer tick, asking Buildbucket for the build status
[05:03:52.634] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:52.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:38:0) after 1m0s
[05:04:52.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:38:0)
[05:04:52.655] Timer tick, asking Buildbucket for the build status
[05:04:53.144] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:53.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:39:0) after 1m0s
[05:05:53.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:39:0)
[05:05:53.198] Timer tick, asking Buildbucket for the build status
[05:05:53.293] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:53.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:40:0) after 1m0s
[05:06:53.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:40:0)
[05:06:53.278] Timer tick, asking Buildbucket for the build status
[05:06:53.315] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:53.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:41:0) after 1m0s
[05:07:53.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:41:0)
[05:07:53.336] Timer tick, asking Buildbucket for the build status
[05:07:53.419] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:53.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:42:0) after 1m0s
[05:08:53.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:42:0)
[05:08:53.479] Timer tick, asking Buildbucket for the build status
[05:08:53.689] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:53.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:43:0) after 1m0s
[05:09:53.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:43:0)
[05:09:53.691] Timer tick, asking Buildbucket for the build status
[05:09:53.753] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:53.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:44:0) after 1m0s
[05:10:53.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:44:0)
[05:10:53.762] Timer tick, asking Buildbucket for the build status
[05:10:53.881] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:53.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:45:0) after 1m0s
[05:11:53.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:45:0)
[05:11:53.892] Timer tick, asking Buildbucket for the build status
[05:11:53.934] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:53.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:46:0) after 1m0s
[05:12:53.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:46:0)
[05:12:53.953] Timer tick, asking Buildbucket for the build status
[05:12:54.003] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:54.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:47:0) after 1m0s
[05:13:53.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:47:0)
[05:13:53.981] Timer tick, asking Buildbucket for the build status
[05:13:54.044] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:54.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:48:0) after 1m0s
[05:14:54.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:48:0)
[05:14:54.036] Timer tick, asking Buildbucket for the build status
[05:14:54.073] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:54.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:49:0) after 1m0s
[05:15:54.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:49:0)
[05:15:54.094] Timer tick, asking Buildbucket for the build status
[05:15:54.184] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:54.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:50:0) after 1m0s
[05:16:54.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:50:0)
[05:16:54.194] Timer tick, asking Buildbucket for the build status
[05:16:54.288] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:54.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:51:0) after 1m0s
[05:17:54.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:51:0)
[05:17:54.315] Timer tick, asking Buildbucket for the build status
[05:17:54.386] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:54.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:52:0) after 1m0s
[05:18:54.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:52:0)
[05:18:54.405] Timer tick, asking Buildbucket for the build status
[05:18:54.512] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:54.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:53:0) after 1m0s
[05:19:54.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:53:0)
[05:19:54.531] Timer tick, asking Buildbucket for the build status
[05:19:54.582] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:54.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:54:0) after 1m0s
[05:20:54.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:54:0)
[05:20:54.594] Timer tick, asking Buildbucket for the build status
[05:20:54.636] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:54.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:55:0) after 1m0s
[05:21:54.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:55:0)
[05:21:54.662] Timer tick, asking Buildbucket for the build status
[05:21:54.742] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:54.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:56:0) after 1m0s
[05:22:54.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:56:0)
[05:22:54.732] Timer tick, asking Buildbucket for the build status
[05:22:58.652] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:58.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:57:0) after 1m0s
[05:23:58.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:57:0)
[05:23:58.715] Timer tick, asking Buildbucket for the build status
[05:23:58.751] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:58.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:58:0) after 1m0s
[05:24:58.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:58:0)
[05:24:58.760] Timer tick, asking Buildbucket for the build status
[05:24:58.833] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:59:0) after 1m0s
[05:25:58.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:59:0)
[05:25:58.857] Timer tick, asking Buildbucket for the build status
[05:25:58.971] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:58.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:60:0) after 1m0s
[05:26:58.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:60:0)
[05:26:58.994] Timer tick, asking Buildbucket for the build status
[05:26:59.065] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:59.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:61:0) after 1m0s
[05:27:59.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:61:0)
[05:27:59.048] Timer tick, asking Buildbucket for the build status
[05:27:59.175] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:59.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:62:0) after 1m0s
[05:28:59.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:62:0)
[05:28:59.201] Timer tick, asking Buildbucket for the build status
[05:28:59.239] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:59.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:63:0) after 1m0s
[05:29:59.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:63:0)
[05:29:59.263] Timer tick, asking Buildbucket for the build status
[05:29:59.371] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:59.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:64:0) after 1m0s
[05:30:59.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:64:0)
[05:30:59.350] Timer tick, asking Buildbucket for the build status
[05:30:59.416] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:59.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:65:0) after 1m0s
[05:31:59.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:65:0)
[05:31:59.426] Timer tick, asking Buildbucket for the build status
[05:31:59.584] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:59.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:66:0) after 1m0s
[05:32:59.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:66:0)
[05:32:59.563] Timer tick, asking Buildbucket for the build status
[05:32:59.615] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:59.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:67:0) after 1m0s
[05:33:59.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:67:0)
[05:33:59.637] Timer tick, asking Buildbucket for the build status
[05:33:59.716] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:59.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:68:0) after 1m0s
[05:34:59.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:68:0)
[05:34:59.742] Timer tick, asking Buildbucket for the build status
[05:34:59.820] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:59.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:69:0) after 1m0s
[05:35:59.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:69:0)
[05:35:59.842] Timer tick, asking Buildbucket for the build status
[05:35:59.981] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:59.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:70:0) after 1m0s
[05:37:00.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:70:0)
[05:37:00.003] Timer tick, asking Buildbucket for the build status
[05:37:00.049] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:00.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:71:0) after 1m0s
[05:38:00.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:71:0)
[05:38:00.109] Timer tick, asking Buildbucket for the build status
[05:38:00.196] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:00.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:72:0) after 1m0s
[05:39:00.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:72:0)
[05:39:00.177] Timer tick, asking Buildbucket for the build status
[05:39:00.275] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:00.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:73:0) after 1m0s
[05:40:00.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:73:0)
[05:40:00.298] Timer tick, asking Buildbucket for the build status
[05:40:00.402] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:00.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:74:0) after 1m0s
[05:41:00.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:74:0)
[05:41:00.411] Timer tick, asking Buildbucket for the build status
[05:41:00.567] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:00.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:75:0) after 1m0s
[05:42:00.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:75:0)
[05:42:00.618] Timer tick, asking Buildbucket for the build status
[05:42:00.736] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:00.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:76:0) after 1m0s
[05:43:00.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:76:0)
[05:43:00.819] Timer tick, asking Buildbucket for the build status
[05:43:00.900] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:00.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:77:0) after 1m0s
[05:44:00.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:77:0)
[05:44:00.922] Timer tick, asking Buildbucket for the build status
[05:44:01.106] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:01.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:78:0) after 1m0s
[05:45:01.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:78:0)
[05:45:01.128] Timer tick, asking Buildbucket for the build status
[05:45:01.192] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:01.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:79:0) after 1m0s
[05:46:01.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:79:0)
[05:46:01.195] Timer tick, asking Buildbucket for the build status
[05:46:01.313] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:01.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:80:0) after 1m0s
[05:47:01.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:80:0)
[05:47:01.321] Timer tick, asking Buildbucket for the build status
[05:47:01.719] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:01.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:81:0) after 1m0s
[05:48:01.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:81:0)
[05:48:01.717] Timer tick, asking Buildbucket for the build status
[05:48:01.841] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:01.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:82:0) after 1m0s
[05:49:01.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:82:0)
[05:49:01.860] Timer tick, asking Buildbucket for the build status
[05:49:01.898] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:01.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:83:0) after 1m0s
[05:50:01.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:83:0)
[05:50:01.913] Timer tick, asking Buildbucket for the build status
[05:50:01.975] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:01.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:84:0) after 1m0s
[05:51:01.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:84:0)
[05:51:01.969] Timer tick, asking Buildbucket for the build status
[05:51:02.071] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:02.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:85:0) after 1m0s
[05:52:02.072] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:85:0)
[05:52:02.072] Timer tick, asking Buildbucket for the build status
[05:52:02.226] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:02.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:86:0) after 1m0s
[05:53:02.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:86:0)
[05:53:02.228] Timer tick, asking Buildbucket for the build status
[05:53:02.296] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:02.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:87:0) after 1m0s
[05:54:02.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:87:0)
[05:54:02.398] Timer tick, asking Buildbucket for the build status
[05:54:02.462] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:02.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:88:0) after 1m0s
[05:55:02.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:88:0)
[05:55:02.481] Timer tick, asking Buildbucket for the build status
[05:55:02.565] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:02.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:89:0) after 1m0s
[05:56:02.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:89:0)
[05:56:02.583] Timer tick, asking Buildbucket for the build status
[05:56:02.687] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:02.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:90:0) after 1m0s
[05:57:02.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:90:0)
[05:57:02.697] Timer tick, asking Buildbucket for the build status
[05:57:02.858] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:02.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:91:0) after 1m0s
[05:58:02.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:91:0)
[05:58:02.863] Timer tick, asking Buildbucket for the build status
[05:58:02.985] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:02.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:92:0) after 1m0s
[05:59:03.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:92:0)
[05:59:03.008] Timer tick, asking Buildbucket for the build status
[05:59:03.054] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:03.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:93:0) after 1m0s
[06:00:03.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:93:0)
[06:00:03.058] Timer tick, asking Buildbucket for the build status
[06:00:03.147] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:03.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:94:0) after 1m0s
[06:01:03.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:94:0)
[06:01:03.167] Timer tick, asking Buildbucket for the build status
[06:01:03.262] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:03.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:95:0) after 1m0s
[06:02:03.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:95:0)
[06:02:03.238] Timer tick, asking Buildbucket for the build status
[06:02:03.309] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:03.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:96:0) after 1m0s
[06:03:03.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:96:0)
[06:03:03.336] Timer tick, asking Buildbucket for the build status
[06:03:03.374] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:03.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:97:0) after 1m0s
[06:04:03.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:97:0)
[06:04:03.391] Timer tick, asking Buildbucket for the build status
[06:04:03.585] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:03.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:98:0) after 1m0s
[06:05:03.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:98:0)
[06:05:03.617] Timer tick, asking Buildbucket for the build status
[06:05:03.727] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:03.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:99:0) after 1m0s
[06:06:03.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:99:0)
[06:06:03.753] Timer tick, asking Buildbucket for the build status
[06:06:03.825] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:03.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:100:0) after 1m0s
[06:07:03.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:100:0)
[06:07:03.836] Timer tick, asking Buildbucket for the build status
[06:07:03.901] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:03.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:101:0) after 1m0s
[06:08:03.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:101:0)
[06:08:03.917] Timer tick, asking Buildbucket for the build status
[06:08:03.970] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:03.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:102:0) after 1m0s
[06:09:03.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:102:0)
[06:09:03.971] Timer tick, asking Buildbucket for the build status
[06:09:04.074] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:04.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:103:0) after 1m0s
[06:10:04.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:103:0)
[06:10:04.157] Timer tick, asking Buildbucket for the build status
[06:10:04.204] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:04.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:104:0) after 1m0s
[06:11:04.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:104:0)
[06:11:04.221] Timer tick, asking Buildbucket for the build status
[06:11:04.258] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:04.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:105:0) after 1m0s
[06:12:04.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:105:0)
[06:12:04.282] Timer tick, asking Buildbucket for the build status
[06:12:04.323] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:04.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:106:0) after 1m0s
[06:13:04.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:106:0)
[06:13:04.318] Timer tick, asking Buildbucket for the build status
[06:13:04.438] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:107:0) after 1m0s
[06:14:04.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:107:0)
[06:14:04.453] Timer tick, asking Buildbucket for the build status
[06:14:04.507] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:04.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:108:0) after 1m0s
[06:15:04.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:108:0)
[06:15:04.542] Timer tick, asking Buildbucket for the build status
[06:15:04.677] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:04.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:109:0) after 1m0s
[06:16:04.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:109:0)
[06:16:04.667] Timer tick, asking Buildbucket for the build status
[06:16:04.705] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:04.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:110:0) after 1m0s
[06:17:04.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:110:0)
[06:17:04.724] Timer tick, asking Buildbucket for the build status
[06:17:05.111] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:05.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:111:0) after 1m0s
[06:18:05.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:111:0)
[06:18:05.146] Timer tick, asking Buildbucket for the build status
[06:18:05.206] Build 8919221109843367344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:05.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9084651171860231040:112:0) after 1m0s
[06:18:31.901] Received PubSub notification, asking Buildbucket for the build status
[06:18:31.994] Build 8919221109843367344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:18:31.994] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1552371510765762",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552364927401432",
"id": "8919221109843367344",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7d74603acc17e17f8eb37151de6b5afeabf4ae5d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"id\": [\"win10-727f49a0-us-west1-b-kb2j\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4158-1053c58\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"got_nacl_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27058}\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"got_swarming_client_revision\": \"7a61cf37d6a0163f0ec02d495289a1d038e62457\", \"got_webrtc_revision\": \"a5c0ba186149569832548bc3ea01494562fbcab7\", \"got_revision\": \"7d74603acc17e17f8eb37151de6b5afeabf4ae5d\", \"buildername\": \"Windows deterministic\", \"recipe\": \"swarming/deterministic_build\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"0f34f3f2f78533343b0dfdb410db7c7f2eafae76\", \"got_v8_revision\": \"4e74864a971dc6992f308d476b1b7b779085ae14\", \"got_revision_cp\": \"refs/heads/master@{#639815}\", \"got_dawn_revision\": \"1e1c13ed87bae248e044fdd6fec9c5ab7efccf41\", \"branch\": \"refs/heads/master\", \"buildnumber\": 12393, \"path_config\": \"generic\", \"bot_id\": \"win10-727f49a0-us-west1-b-kb2j\", \"got_v8_revision_cp\": \"refs/heads/7.5.16@{#1}\", \"revision\": \"7d74603acc17e17f8eb37151de6b5afeabf4ae5d\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552364929306921",
"status": "COMPLETED",
"status_changed_ts": "1552371511583042",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12393",
"builder:Windows deterministic",
"buildset:commit/git/7d74603acc17e17f8eb37151de6b5afeabf4ae5d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d74603acc17e17f8eb37151de6b5afeabf4ae5d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084651171860231040",
"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/8919221109843367344/+/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:4388fa83972a0510",
"user_agent:luci-scheduler"
],
"updated_ts": "1552371511602557",
"url": "https://ci.chromium.org/b/8919221109843367344",
"utcnow_ts": "1552371511987022"
}
}
[06:18:31.994] Invocation finished in 1h49m45.899779205s with status SUCCEEDED