[08:52:00.157] New invocation is queued and will start shortly
[08:52:01.234] Starting the invocation (attempt 1)
[08:52:01.300] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:52:01.300] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:52:01.300] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083094462174161472",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"6e352d3c9cbba878f3ba23e739c877e776515486\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9083094462174161472",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/6e352d3c9cbba878f3ba23e739c877e776515486",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e352d3c9cbba878f3ba23e739c877e776515486",
"gitiles_ref:refs/heads/master"
]
}
[08:52:02.009] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553849521466788",
"id": "8917664400137443728",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6e352d3c9cbba878f3ba23e739c877e776515486\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553849521902436",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12619",
"builder:Windows deterministic",
"buildset:commit/git/6e352d3c9cbba878f3ba23e739c877e776515486",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e352d3c9cbba878f3ba23e739c877e776515486",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083094462174161472",
"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/8917664400137443728/+/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:",
"user_agent:luci-scheduler"
],
"updated_ts": "1553849521902563",
"url": "https://ci.chromium.org/b/8917664400137443728",
"utcnow_ts": "1553849521998189"
}
}
[08:52:02.009] Task URL: https://ci.chromium.org/b/8917664400137443728
[08:52:02.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:2:0) after 1m0s
[08:52:04.819] Received PubSub notification, asking Buildbucket for the build status
[08:52:05.241] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:02.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:2:0)
[08:53:02.005] Timer tick, asking Buildbucket for the build status
[08:53:02.173] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:02.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:4:0) after 1m0s
[08:54:02.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:4:0)
[08:54:02.159] Timer tick, asking Buildbucket for the build status
[08:54:02.893] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:02.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:5:0) after 1m0s
[08:55:02.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:5:0)
[08:55:02.877] Timer tick, asking Buildbucket for the build status
[08:55:02.991] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:02.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:6:0) after 1m0s
[08:56:03.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:6:0)
[08:56:03.009] Timer tick, asking Buildbucket for the build status
[08:56:03.141] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:03.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:7:0) after 1m0s
[08:57:03.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:7:0)
[08:57:03.160] Timer tick, asking Buildbucket for the build status
[08:57:03.382] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:03.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:8:0) after 1m0s
[08:58:03.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:8:0)
[08:58:03.423] Timer tick, asking Buildbucket for the build status
[08:58:03.677] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:03.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:9:0) after 1m0s
[08:59:03.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:9:0)
[08:59:03.701] Timer tick, asking Buildbucket for the build status
[08:59:03.827] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:03.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:10:0) after 1m0s
[09:00:03.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:10:0)
[09:00:03.846] Timer tick, asking Buildbucket for the build status
[09:00:04.589] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:04.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:11:0) after 1m0s
[09:01:04.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:11:0)
[09:01:04.607] Timer tick, asking Buildbucket for the build status
[09:01:05.456] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:05.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:12:0) after 1m0s
[09:02:05.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:12:0)
[09:02:05.494] Timer tick, asking Buildbucket for the build status
[09:02:05.686] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:05.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:13:0) after 1m0s
[09:03:05.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:13:0)
[09:03:05.909] Timer tick, asking Buildbucket for the build status
[09:03:06.042] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:06.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:14:0) after 1m0s
[09:04:06.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:14:0)
[09:04:06.062] Timer tick, asking Buildbucket for the build status
[09:04:06.244] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:06.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:15:0) after 1m0s
[09:05:06.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:15:0)
[09:05:06.262] Timer tick, asking Buildbucket for the build status
[09:05:06.875] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:06.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:16:0) after 1m0s
[09:06:06.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:16:0)
[09:06:06.896] Timer tick, asking Buildbucket for the build status
[09:06:07.168] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:07.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:17:0) after 1m0s
[09:07:07.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:17:0)
[09:07:07.198] Timer tick, asking Buildbucket for the build status
[09:07:07.797] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:07.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:18:0) after 1m0s
[09:08:07.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:18:0)
[09:08:07.809] Timer tick, asking Buildbucket for the build status
[09:08:08.278] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:08.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:19:0) after 1m0s
[09:09:08.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:19:0)
[09:09:08.296] Timer tick, asking Buildbucket for the build status
[09:09:08.706] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:08.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:20:0) after 1m0s
[09:10:08.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:20:0)
[09:10:08.744] Timer tick, asking Buildbucket for the build status
[09:10:09.163] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:09.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:21:0) after 1m0s
[09:11:09.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:21:0)
[09:11:09.188] Timer tick, asking Buildbucket for the build status
[09:11:09.320] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:09.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:22:0) after 1m0s
[09:12:09.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:22:0)
[09:12:09.393] Timer tick, asking Buildbucket for the build status
[09:12:09.701] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:23:0) after 1m0s
[09:13:09.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:23:0)
[09:13:09.718] Timer tick, asking Buildbucket for the build status
[09:13:09.886] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:09.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:24:0) after 1m0s
[09:14:09.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:24:0)
[09:14:09.901] Timer tick, asking Buildbucket for the build status
[09:14:10.465] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:10.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:25:0) after 1m0s
[09:15:10.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:25:0)
[09:15:10.475] Timer tick, asking Buildbucket for the build status
[09:15:10.968] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:10.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:26:0) after 1m0s
[09:16:10.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:26:0)
[09:16:10.988] Timer tick, asking Buildbucket for the build status
[09:16:11.121] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:11.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:27:0) after 1m0s
[09:17:11.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:27:0)
[09:17:11.112] Timer tick, asking Buildbucket for the build status
[09:17:11.216] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:11.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:28:0) after 1m0s
[09:18:11.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:28:0)
[09:18:11.213] Timer tick, asking Buildbucket for the build status
[09:18:11.362] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:11.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:29:0) after 1m0s
[09:19:11.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:29:0)
[09:19:11.382] Timer tick, asking Buildbucket for the build status
[09:19:11.775] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:11.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:30:0) after 1m0s
[09:20:11.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:30:0)
[09:20:11.794] Timer tick, asking Buildbucket for the build status
[09:20:11.932] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:11.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:31:0) after 1m0s
[09:21:11.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:31:0)
[09:21:11.949] Timer tick, asking Buildbucket for the build status
[09:21:12.090] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:12.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:32:0) after 1m0s
[09:22:12.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:32:0)
[09:22:12.187] Timer tick, asking Buildbucket for the build status
[09:22:12.335] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:12.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:33:0) after 1m0s
[09:23:12.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:33:0)
[09:23:12.332] Timer tick, asking Buildbucket for the build status
[09:23:12.444] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:12.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:34:0) after 1m0s
[09:24:12.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:34:0)
[09:24:12.455] Timer tick, asking Buildbucket for the build status
[09:24:12.610] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:12.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:35:0) after 1m0s
[09:25:12.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:35:0)
[09:25:12.617] Timer tick, asking Buildbucket for the build status
[09:25:12.875] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:12.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:36:0) after 1m0s
[09:26:12.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:36:0)
[09:26:12.863] Timer tick, asking Buildbucket for the build status
[09:26:13.283] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:13.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:37:0) after 1m0s
[09:27:13.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:37:0)
[09:27:13.302] Timer tick, asking Buildbucket for the build status
[09:27:13.803] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:13.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:38:0) after 1m0s
[09:28:13.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:38:0)
[09:28:13.779] Timer tick, asking Buildbucket for the build status
[09:28:14.334] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:14.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:39:0) after 1m0s
[09:29:14.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:39:0)
[09:29:14.376] Timer tick, asking Buildbucket for the build status
[09:29:15.608] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:40:0) after 1m0s
[09:30:15.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:40:0)
[09:30:15.626] Timer tick, asking Buildbucket for the build status
[09:30:15.749] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:15.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:41:0) after 1m0s
[09:31:15.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:41:0)
[09:31:15.740] Timer tick, asking Buildbucket for the build status
[09:31:15.859] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:15.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:42:0) after 1m0s
[09:32:15.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:42:0)
[09:32:15.888] Timer tick, asking Buildbucket for the build status
[09:32:16.166] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:16.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:43:0) after 1m0s
[09:33:16.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:43:0)
[09:33:16.147] Timer tick, asking Buildbucket for the build status
[09:33:16.297] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:16.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:44:0) after 1m0s
[09:34:16.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:44:0)
[09:34:16.306] Timer tick, asking Buildbucket for the build status
[09:34:16.579] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:16.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:45:0) after 1m0s
[09:35:16.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:45:0)
[09:35:16.592] Timer tick, asking Buildbucket for the build status
[09:35:16.683] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:16.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:46:0) after 1m0s
[09:36:16.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:46:0)
[09:36:16.805] Timer tick, asking Buildbucket for the build status
[09:36:16.932] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:16.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:47:0) after 1m0s
[09:37:16.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:47:0)
[09:37:16.929] Timer tick, asking Buildbucket for the build status
[09:37:17.183] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:17.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:48:0) after 1m0s
[09:38:17.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:48:0)
[09:38:17.196] Timer tick, asking Buildbucket for the build status
[09:38:17.308] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:17.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:49:0) after 1m0s
[09:39:17.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:49:0)
[09:39:17.329] Timer tick, asking Buildbucket for the build status
[09:39:17.694] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:17.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:50:0) after 1m0s
[09:40:17.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:50:0)
[09:40:17.893] Timer tick, asking Buildbucket for the build status
[09:40:18.060] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:18.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:51:0) after 1m0s
[09:41:18.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:51:0)
[09:41:18.125] Timer tick, asking Buildbucket for the build status
[09:41:18.856] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:18.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:52:0) after 1m0s
[09:42:18.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:52:0)
[09:42:18.880] Timer tick, asking Buildbucket for the build status
[09:42:19.198] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:19.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:53:0) after 1m0s
[09:43:19.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:53:0)
[09:43:19.194] Timer tick, asking Buildbucket for the build status
[09:43:19.988] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:19.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:54:0) after 1m0s
[09:44:20.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:54:0)
[09:44:20.079] Timer tick, asking Buildbucket for the build status
[09:44:20.395] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:20.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:55:0) after 1m0s
[09:45:20.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:55:0)
[09:45:20.418] Timer tick, asking Buildbucket for the build status
[09:45:20.803] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:20.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:56:0) after 1m0s
[09:46:20.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:56:0)
[09:46:20.826] Timer tick, asking Buildbucket for the build status
[09:46:21.092] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:21.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:57:0) after 1m0s
[09:47:21.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:57:0)
[09:47:21.099] Timer tick, asking Buildbucket for the build status
[09:47:21.216] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:21.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:58:0) after 1m0s
[09:48:21.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:58:0)
[09:48:21.231] Timer tick, asking Buildbucket for the build status
[09:48:21.403] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:21.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:59:0) after 1m0s
[09:49:21.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:59:0)
[09:49:21.424] Timer tick, asking Buildbucket for the build status
[09:49:21.931] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:21.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:60:0) after 1m0s
[09:50:21.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:60:0)
[09:50:21.951] Timer tick, asking Buildbucket for the build status
[09:50:22.213] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:22.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:61:0) after 1m0s
[09:51:22.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:61:0)
[09:51:22.190] Timer tick, asking Buildbucket for the build status
[09:51:22.304] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:62:0) after 1m0s
[09:52:22.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:62:0)
[09:52:22.317] Timer tick, asking Buildbucket for the build status
[09:52:22.866] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:22.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:63:0) after 1m0s
[09:53:23.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:63:0)
[09:53:23.007] Timer tick, asking Buildbucket for the build status
[09:53:23.122] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:23.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:64:0) after 1m0s
[09:54:23.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:64:0)
[09:54:23.132] Timer tick, asking Buildbucket for the build status
[09:54:23.289] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:23.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:65:0) after 1m0s
[09:55:23.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:65:0)
[09:55:23.315] Timer tick, asking Buildbucket for the build status
[09:55:23.428] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:23.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:66:0) after 1m0s
[09:56:23.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:66:0)
[09:56:23.454] Timer tick, asking Buildbucket for the build status
[09:56:23.571] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:23.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:67:0) after 1m0s
[09:57:23.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:67:0)
[09:57:23.590] Timer tick, asking Buildbucket for the build status
[09:57:23.714] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:23.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:68:0) after 1m0s
[09:58:23.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:68:0)
[09:58:23.741] Timer tick, asking Buildbucket for the build status
[09:58:23.927] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:23.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:69:0) after 1m0s
[09:59:23.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:69:0)
[09:59:23.922] Timer tick, asking Buildbucket for the build status
[09:59:24.048] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:24.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:70:0) after 1m0s
[10:00:24.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:70:0)
[10:00:24.071] Timer tick, asking Buildbucket for the build status
[10:00:24.191] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:24.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:71:0) after 1m0s
[10:01:24.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:71:0)
[10:01:24.214] Timer tick, asking Buildbucket for the build status
[10:01:24.586] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:24.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:72:0) after 1m0s
[10:02:24.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:72:0)
[10:02:24.606] Timer tick, asking Buildbucket for the build status
[10:02:24.995] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:24.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:73:0) after 1m0s
[10:03:25.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:73:0)
[10:03:25.017] Timer tick, asking Buildbucket for the build status
[10:03:25.430] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:25.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:74:0) after 1m0s
[10:04:25.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:74:0)
[10:04:25.462] Timer tick, asking Buildbucket for the build status
[10:04:25.617] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:25.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:75:0) after 1m0s
[10:05:25.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:75:0)
[10:05:25.655] Timer tick, asking Buildbucket for the build status
[10:05:26.183] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:26.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:76:0) after 1m0s
[10:06:26.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:76:0)
[10:06:26.203] Timer tick, asking Buildbucket for the build status
[10:06:26.401] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:26.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:77:0) after 1m0s
[10:07:26.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:77:0)
[10:07:26.430] Timer tick, asking Buildbucket for the build status
[10:07:26.514] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:26.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:78:0) after 1m0s
[10:08:26.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:78:0)
[10:08:26.517] Timer tick, asking Buildbucket for the build status
[10:08:26.649] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:26.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:79:0) after 1m0s
[10:09:26.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:79:0)
[10:09:26.702] Timer tick, asking Buildbucket for the build status
[10:09:26.847] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:26.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:80:0) after 1m0s
[10:10:26.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:80:0)
[10:10:26.822] Timer tick, asking Buildbucket for the build status
[10:10:26.926] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:26.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:81:0) after 1m0s
[10:11:26.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:81:0)
[10:11:26.968] Timer tick, asking Buildbucket for the build status
[10:11:27.687] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:27.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:82:0) after 1m0s
[10:12:27.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:82:0)
[10:12:27.725] Timer tick, asking Buildbucket for the build status
[10:12:27.826] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:27.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:83:0) after 1m0s
[10:13:27.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:83:0)
[10:13:27.837] Timer tick, asking Buildbucket for the build status
[10:13:27.997] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:27.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:84:0) after 1m0s
[10:14:28.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:84:0)
[10:14:28.034] Timer tick, asking Buildbucket for the build status
[10:14:28.168] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:28.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:85:0) after 1m0s
[10:15:28.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:85:0)
[10:15:28.192] Timer tick, asking Buildbucket for the build status
[10:15:28.341] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:28.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:86:0) after 1m0s
[10:16:28.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:86:0)
[10:16:28.353] Timer tick, asking Buildbucket for the build status
[10:16:28.995] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:28.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:87:0) after 1m0s
[10:17:28.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:87:0)
[10:17:28.981] Timer tick, asking Buildbucket for the build status
[10:17:29.765] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:29.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:88:0) after 1m0s
[10:18:29.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:88:0)
[10:18:29.806] Timer tick, asking Buildbucket for the build status
[10:18:29.969] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:29.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:89:0) after 1m0s
[10:19:29.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:89:0)
[10:19:29.993] Timer tick, asking Buildbucket for the build status
[10:19:30.830] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:30.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:90:0) after 1m0s
[10:20:30.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:90:0)
[10:20:30.852] Timer tick, asking Buildbucket for the build status
[10:20:30.970] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:30.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:91:0) after 1m0s
[10:21:31.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:91:0)
[10:21:31.023] Timer tick, asking Buildbucket for the build status
[10:21:31.127] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:31.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:92:0) after 1m0s
[10:22:31.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:92:0)
[10:22:31.192] Timer tick, asking Buildbucket for the build status
[10:22:31.316] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:31.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:93:0) after 1m0s
[10:23:31.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:93:0)
[10:23:31.372] Timer tick, asking Buildbucket for the build status
[10:23:31.516] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:31.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:94:0) after 1m0s
[10:24:31.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:94:0)
[10:24:31.550] Timer tick, asking Buildbucket for the build status
[10:24:31.653] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:31.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:95:0) after 1m0s
[10:25:31.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:95:0)
[10:25:31.695] Timer tick, asking Buildbucket for the build status
[10:25:31.893] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:31.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:96:0) after 1m0s
[10:26:31.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:96:0)
[10:26:31.915] Timer tick, asking Buildbucket for the build status
[10:26:32.089] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:32.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:97:0) after 1m0s
[10:27:32.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:97:0)
[10:27:32.184] Timer tick, asking Buildbucket for the build status
[10:27:32.337] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:32.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:98:0) after 1m0s
[10:28:32.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:98:0)
[10:28:32.360] Timer tick, asking Buildbucket for the build status
[10:28:32.789] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:32.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:99:0) after 1m0s
[10:29:32.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:99:0)
[10:29:32.814] Timer tick, asking Buildbucket for the build status
[10:29:32.926] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:32.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:100:0) after 1m0s
[10:30:32.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:100:0)
[10:30:32.947] Timer tick, asking Buildbucket for the build status
[10:30:33.059] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:33.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:101:0) after 1m0s
[10:31:33.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:101:0)
[10:31:33.085] Timer tick, asking Buildbucket for the build status
[10:31:33.249] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:33.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:102:0) after 1m0s
[10:32:33.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:102:0)
[10:32:33.300] Timer tick, asking Buildbucket for the build status
[10:32:33.448] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:33.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:103:0) after 1m0s
[10:33:33.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:103:0)
[10:33:33.520] Timer tick, asking Buildbucket for the build status
[10:33:33.719] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:33.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:104:0) after 1m0s
[10:34:33.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:104:0)
[10:34:33.719] Timer tick, asking Buildbucket for the build status
[10:34:33.826] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:33.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:105:0) after 1m0s
[10:35:33.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:105:0)
[10:35:33.838] Timer tick, asking Buildbucket for the build status
[10:35:34.274] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:34.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:106:0) after 1m0s
[10:36:34.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:106:0)
[10:36:34.310] Timer tick, asking Buildbucket for the build status
[10:36:34.913] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:34.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:107:0) after 1m0s
[10:37:34.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:107:0)
[10:37:34.928] Timer tick, asking Buildbucket for the build status
[10:37:35.019] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:35.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:108:0) after 1m0s
[10:38:35.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:108:0)
[10:38:35.103] Timer tick, asking Buildbucket for the build status
[10:38:35.236] Build 8917664400137443728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:35.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083094462174161472:109:0) after 1m0s
[10:39:14.670] Received PubSub notification, asking Buildbucket for the build status
[10:39:15.366] Build 8917664400137443728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:39:15.366] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553855954225732",
"created_by": "project:chromium",
"created_ts": "1553849521466788",
"id": "8917664400137443728",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6e352d3c9cbba878f3ba23e739c877e776515486\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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}, \"bot_id\": \"windows-deterministic-0-93fj\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 12619, \"got_angle_revision\": \"6446c8882fa3efe151b1ee451554e68d10802cc7\", \"got_dawn_revision\": \"10c24684ab9cd1c747e251d7cb4590c43eecad6b\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"6e352d3c9cbba878f3ba23e739c877e776515486\", \"got_revision_cp\": \"refs/heads/master@{#645702}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"7f2d661917a4efc04efaac8f53c06518b2c19f89\", \"got_v8_revision_cp\": \"refs/heads/7.5.140@{#1}\", \"got_webrtc_revision\": \"b118d428499844749df6dd28aa3dbc8d5e1484fe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27352}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6e352d3c9cbba878f3ba23e739c877e776515486\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-93fj\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4226-cfe6277\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553849524178890",
"status": "COMPLETED",
"status_changed_ts": "1553855954500647",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12619",
"builder:Windows deterministic",
"buildset:commit/git/6e352d3c9cbba878f3ba23e739c877e776515486",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e352d3c9cbba878f3ba23e739c877e776515486",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083094462174161472",
"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/8917664400137443728/+/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:43e177a1e8d96110",
"user_agent:luci-scheduler"
],
"updated_ts": "1553855954503864",
"url": "https://ci.chromium.org/b/8917664400137443728",
"utcnow_ts": "1553855955322664"
}
}
[10:39:15.366] Invocation finished in 1h47m15.2263241s with status SUCCEEDED