[09:52:00.249] New invocation is queued and will start shortly
[09:52:01.630] Starting the invocation (attempt 1)
[09:52:01.668] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:52:01.669] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:52:01.669] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9044949364350868768",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cfec860f7b9a62cf226094367d7a9f93f4e38a30\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9044949364350868768",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/cfec860f7b9a62cf226094367d7a9f93f4e38a30",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfec860f7b9a62cf226094367d7a9f93f4e38a30",
"gitiles_ref:refs/heads/master"
]
}
[09:52:02.751] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1590227521785071",
"id": "8879519302075504336",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfec860f7b9a62cf226094367d7a9f93f4e38a30\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590227522351854",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16545",
"builder:Windows deterministic",
"buildset:commit/git/cfec860f7b9a62cf226094367d7a9f93f4e38a30",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfec860f7b9a62cf226094367d7a9f93f4e38a30",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044949364350868768",
"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/8879519302075504336/+/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": "1590227522351976",
"url": "https://ci.chromium.org/b/8879519302075504336",
"utcnow_ts": "1590227522741993"
}
}
[09:52:02.751] Task URL: https://ci.chromium.org/b/8879519302075504336
[09:52:02.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:2:0) after 1m0s
[09:52:05.571] Received PubSub notification, asking Buildbucket for the build status
[09:52:06.906] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:02.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:2:0)
[09:53:02.818] Timer tick, asking Buildbucket for the build status
[09:53:03.004] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:03.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:4:0) after 1m0s
[09:54:03.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:4:0)
[09:54:03.034] Timer tick, asking Buildbucket for the build status
[09:54:03.868] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:03.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:5:0) after 1m0s
[09:55:03.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:5:0)
[09:55:03.943] Timer tick, asking Buildbucket for the build status
[09:55:04.042] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:04.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:6:0) after 1m0s
[09:56:04.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:6:0)
[09:56:04.065] Timer tick, asking Buildbucket for the build status
[09:56:04.241] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:04.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:7:0) after 1m0s
[09:57:04.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:7:0)
[09:57:04.272] Timer tick, asking Buildbucket for the build status
[09:57:04.396] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:04.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:8:0) after 1m0s
[09:58:04.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:8:0)
[09:58:04.419] Timer tick, asking Buildbucket for the build status
[09:58:04.967] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:04.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:9:0) after 1m0s
[09:59:04.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:9:0)
[09:59:04.985] Timer tick, asking Buildbucket for the build status
[09:59:05.238] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:05.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:10:0) after 1m0s
[10:00:05.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:10:0)
[10:00:05.263] Timer tick, asking Buildbucket for the build status
[10:00:05.413] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:05.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:11:0) after 1m0s
[10:01:05.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:11:0)
[10:01:05.432] Timer tick, asking Buildbucket for the build status
[10:01:05.619] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:05.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:12:0) after 1m0s
[10:02:05.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:12:0)
[10:02:05.621] Timer tick, asking Buildbucket for the build status
[10:02:05.800] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:05.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:13:0) after 1m0s
[10:03:05.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:13:0)
[10:03:05.872] Timer tick, asking Buildbucket for the build status
[10:03:06.311] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:06.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:14:0) after 1m0s
[10:04:06.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:14:0)
[10:04:06.383] Timer tick, asking Buildbucket for the build status
[10:04:06.696] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:06.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:15:0) after 1m0s
[10:05:06.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:15:0)
[10:05:06.776] Timer tick, asking Buildbucket for the build status
[10:05:07.072] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:16:0) after 1m0s
[10:06:07.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:16:0)
[10:06:07.144] Timer tick, asking Buildbucket for the build status
[10:06:07.732] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:07.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:17:0) after 1m0s
[10:07:07.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:17:0)
[10:07:07.800] Timer tick, asking Buildbucket for the build status
[10:07:07.961] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:07.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:18:0) after 1m0s
[10:08:07.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:18:0)
[10:08:07.997] Timer tick, asking Buildbucket for the build status
[10:08:08.155] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:08.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:19:0) after 1m0s
[10:09:08.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:19:0)
[10:09:08.278] Timer tick, asking Buildbucket for the build status
[10:09:08.445] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:08.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:20:0) after 1m0s
[10:10:08.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:20:0)
[10:10:08.475] Timer tick, asking Buildbucket for the build status
[10:10:08.646] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:08.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:21:0) after 1m0s
[10:11:08.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:21:0)
[10:11:08.677] Timer tick, asking Buildbucket for the build status
[10:11:08.797] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:08.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:22:0) after 1m0s
[10:12:08.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:22:0)
[10:12:08.893] Timer tick, asking Buildbucket for the build status
[10:12:10.053] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:23:0) after 1m0s
[10:13:10.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:23:0)
[10:13:10.103] Timer tick, asking Buildbucket for the build status
[10:13:10.695] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:10.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:24:0) after 1m0s
[10:14:10.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:24:0)
[10:14:10.720] Timer tick, asking Buildbucket for the build status
[10:14:10.852] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:10.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:25:0) after 1m0s
[10:15:10.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:25:0)
[10:15:10.875] Timer tick, asking Buildbucket for the build status
[10:15:11.082] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:11.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:26:0) after 1m0s
[10:16:11.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:26:0)
[10:16:11.135] Timer tick, asking Buildbucket for the build status
[10:16:11.302] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:11.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:27:0) after 1m0s
[10:17:11.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:27:0)
[10:17:11.362] Timer tick, asking Buildbucket for the build status
[10:17:11.741] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:11.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:28:0) after 1m0s
[10:18:11.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:28:0)
[10:18:11.747] Timer tick, asking Buildbucket for the build status
[10:18:12.082] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:12.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:29:0) after 1m0s
[10:19:12.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:29:0)
[10:19:12.075] Timer tick, asking Buildbucket for the build status
[10:19:12.222] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:12.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:30:0) after 1m0s
[10:20:12.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:30:0)
[10:20:12.247] Timer tick, asking Buildbucket for the build status
[10:20:12.564] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:12.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:31:0) after 1m0s
[10:21:12.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:31:0)
[10:21:12.572] Timer tick, asking Buildbucket for the build status
[10:21:13.068] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:13.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:32:0) after 1m0s
[10:22:13.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:32:0)
[10:22:13.093] Timer tick, asking Buildbucket for the build status
[10:22:13.679] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:13.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:33:0) after 1m0s
[10:23:13.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:33:0)
[10:23:13.703] Timer tick, asking Buildbucket for the build status
[10:23:13.857] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:13.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:34:0) after 1m0s
[10:24:13.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:34:0)
[10:24:13.880] Timer tick, asking Buildbucket for the build status
[10:24:13.974] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:13.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:35:0) after 1m0s
[10:25:14.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:35:0)
[10:25:14.003] Timer tick, asking Buildbucket for the build status
[10:25:14.240] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:14.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:36:0) after 1m0s
[10:26:14.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:36:0)
[10:26:14.263] Timer tick, asking Buildbucket for the build status
[10:26:14.392] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:14.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:37:0) after 1m0s
[10:27:14.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:37:0)
[10:27:14.412] Timer tick, asking Buildbucket for the build status
[10:27:15.002] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:15.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:38:0) after 1m0s
[10:28:15.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:38:0)
[10:28:15.024] Timer tick, asking Buildbucket for the build status
[10:28:15.214] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:15.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:39:0) after 1m0s
[10:29:15.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:39:0)
[10:29:15.233] Timer tick, asking Buildbucket for the build status
[10:29:15.335] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:15.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:40:0) after 1m0s
[10:30:15.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:40:0)
[10:30:15.437] Timer tick, asking Buildbucket for the build status
[10:30:15.591] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:15.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:41:0) after 1m0s
[10:31:15.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:41:0)
[10:31:15.611] Timer tick, asking Buildbucket for the build status
[10:31:15.930] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:15.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:42:0) after 1m0s
[10:32:15.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:42:0)
[10:32:15.957] Timer tick, asking Buildbucket for the build status
[10:32:16.302] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:16.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:43:0) after 1m0s
[10:33:16.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:43:0)
[10:33:16.313] Timer tick, asking Buildbucket for the build status
[10:33:16.565] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:16.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:44:0) after 1m0s
[10:34:16.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:44:0)
[10:34:16.673] Timer tick, asking Buildbucket for the build status
[10:34:16.857] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:16.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:45:0) after 1m0s
[10:35:16.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:45:0)
[10:35:16.895] Timer tick, asking Buildbucket for the build status
[10:35:17.069] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:17.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:46:0) after 1m0s
[10:36:17.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:46:0)
[10:36:17.075] Timer tick, asking Buildbucket for the build status
[10:36:17.267] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:17.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:47:0) after 1m0s
[10:37:17.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:47:0)
[10:37:17.336] Timer tick, asking Buildbucket for the build status
[10:37:17.746] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:17.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:48:0) after 1m0s
[10:38:17.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:48:0)
[10:38:17.773] Timer tick, asking Buildbucket for the build status
[10:38:17.878] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:17.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:49:0) after 1m0s
[10:39:18.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:49:0)
[10:39:18.001] Timer tick, asking Buildbucket for the build status
[10:39:18.152] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:18.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:50:0) after 1m0s
[10:40:18.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:50:0)
[10:40:18.140] Timer tick, asking Buildbucket for the build status
[10:40:18.300] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:18.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:51:0) after 1m0s
[10:41:18.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:51:0)
[10:41:18.330] Timer tick, asking Buildbucket for the build status
[10:41:18.760] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:18.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:52:0) after 1m0s
[10:42:18.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:52:0)
[10:42:18.832] Timer tick, asking Buildbucket for the build status
[10:42:19.061] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:19.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:53:0) after 1m0s
[10:43:19.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:53:0)
[10:43:19.084] Timer tick, asking Buildbucket for the build status
[10:43:19.282] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:19.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:54:0) after 1m0s
[10:44:19.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:54:0)
[10:44:19.483] Timer tick, asking Buildbucket for the build status
[10:44:19.618] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:19.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:55:0) after 1m0s
[10:45:19.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:55:0)
[10:45:19.792] Timer tick, asking Buildbucket for the build status
[10:45:20.199] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:56:0) after 1m0s
[10:46:20.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:56:0)
[10:46:20.213] Timer tick, asking Buildbucket for the build status
[10:46:20.453] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:20.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:57:0) after 1m0s
[10:47:20.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:57:0)
[10:47:20.574] Timer tick, asking Buildbucket for the build status
[10:47:20.745] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:20.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:58:0) after 1m0s
[10:48:20.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:58:0)
[10:48:20.773] Timer tick, asking Buildbucket for the build status
[10:48:20.925] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:20.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:59:0) after 1m0s
[10:49:20.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:59:0)
[10:49:20.952] Timer tick, asking Buildbucket for the build status
[10:49:21.112] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:21.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:60:0) after 1m0s
[10:50:21.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:60:0)
[10:50:21.139] Timer tick, asking Buildbucket for the build status
[10:50:21.366] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:21.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:61:0) after 1m0s
[10:51:21.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:61:0)
[10:51:21.441] Timer tick, asking Buildbucket for the build status
[10:51:21.746] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:21.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:62:0) after 1m0s
[10:52:21.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:62:0)
[10:52:21.876] Timer tick, asking Buildbucket for the build status
[10:52:22.020] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:22.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:63:0) after 1m0s
[10:53:28.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:63:0)
[10:53:28.305] Timer tick, asking Buildbucket for the build status
[10:53:28.396] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:28.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:64:0) after 1m0s
[10:54:28.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:64:0)
[10:54:28.592] Timer tick, asking Buildbucket for the build status
[10:54:28.748] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:28.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:65:0) after 1m0s
[10:55:28.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:65:0)
[10:55:28.862] Timer tick, asking Buildbucket for the build status
[10:55:28.981] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:28.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:66:0) after 1m0s
[10:56:29.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:66:0)
[10:56:29.024] Timer tick, asking Buildbucket for the build status
[10:56:29.112] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:29.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:67:0) after 1m0s
[10:57:29.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:67:0)
[10:57:29.248] Timer tick, asking Buildbucket for the build status
[10:57:29.626] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:29.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:68:0) after 1m0s
[10:58:29.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:68:0)
[10:58:29.721] Timer tick, asking Buildbucket for the build status
[10:58:29.845] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:29.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:69:0) after 1m0s
[10:59:29.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:69:0)
[10:59:29.883] Timer tick, asking Buildbucket for the build status
[10:59:30.047] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:30.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:70:0) after 1m0s
[11:00:30.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:70:0)
[11:00:30.135] Timer tick, asking Buildbucket for the build status
[11:00:30.451] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:30.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:71:0) after 1m0s
[11:01:30.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:71:0)
[11:01:30.613] Timer tick, asking Buildbucket for the build status
[11:01:31.604] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:31.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:72:0) after 1m0s
[11:02:31.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:72:0)
[11:02:31.712] Timer tick, asking Buildbucket for the build status
[11:02:31.958] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:31.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:73:0) after 1m0s
[11:03:31.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:73:0)
[11:03:31.988] Timer tick, asking Buildbucket for the build status
[11:03:32.209] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:32.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:74:0) after 1m0s
[11:04:32.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:74:0)
[11:04:32.281] Timer tick, asking Buildbucket for the build status
[11:04:32.466] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:32.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:75:0) after 1m0s
[11:05:32.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:75:0)
[11:05:32.542] Timer tick, asking Buildbucket for the build status
[11:05:32.778] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:32.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:76:0) after 1m0s
[11:06:32.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:76:0)
[11:06:32.770] Timer tick, asking Buildbucket for the build status
[11:06:32.920] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:32.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:77:0) after 1m0s
[11:07:32.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:77:0)
[11:07:32.985] Timer tick, asking Buildbucket for the build status
[11:07:33.485] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:33.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:78:0) after 1m0s
[11:08:33.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:78:0)
[11:08:33.564] Timer tick, asking Buildbucket for the build status
[11:08:33.741] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:33.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:79:0) after 1m0s
[11:09:33.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:79:0)
[11:09:33.760] Timer tick, asking Buildbucket for the build status
[11:09:33.911] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:33.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:80:0) after 1m0s
[11:10:34.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:80:0)
[11:10:34.032] Timer tick, asking Buildbucket for the build status
[11:10:34.199] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:34.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:81:0) after 1m0s
[11:11:34.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:81:0)
[11:11:34.225] Timer tick, asking Buildbucket for the build status
[11:11:34.577] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:34.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:82:0) after 1m0s
[11:12:34.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:82:0)
[11:12:34.607] Timer tick, asking Buildbucket for the build status
[11:12:34.814] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:34.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:83:0) after 1m0s
[11:13:34.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:83:0)
[11:13:34.854] Timer tick, asking Buildbucket for the build status
[11:13:35.018] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:84:0) after 1m0s
[11:14:35.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:84:0)
[11:14:35.047] Timer tick, asking Buildbucket for the build status
[11:14:35.322] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:35.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:85:0) after 1m0s
[11:15:35.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:85:0)
[11:15:35.351] Timer tick, asking Buildbucket for the build status
[11:15:35.558] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:35.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:86:0) after 1m0s
[11:16:35.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:86:0)
[11:16:35.581] Timer tick, asking Buildbucket for the build status
[11:16:35.754] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:35.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:87:0) after 1m0s
[11:17:35.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:87:0)
[11:17:35.785] Timer tick, asking Buildbucket for the build status
[11:17:35.932] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:35.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:88:0) after 1m0s
[11:18:35.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:88:0)
[11:18:35.998] Timer tick, asking Buildbucket for the build status
[11:18:36.207] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:36.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:89:0) after 1m0s
[11:19:36.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:89:0)
[11:19:36.220] Timer tick, asking Buildbucket for the build status
[11:19:36.355] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:36.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:90:0) after 1m0s
[11:20:36.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:90:0)
[11:20:36.430] Timer tick, asking Buildbucket for the build status
[11:20:36.718] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:36.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:91:0) after 1m0s
[11:21:36.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:91:0)
[11:21:36.711] Timer tick, asking Buildbucket for the build status
[11:21:36.857] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:36.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:92:0) after 1m0s
[11:22:36.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:92:0)
[11:22:36.988] Timer tick, asking Buildbucket for the build status
[11:22:37.631] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:37.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:93:0) after 1m0s
[11:23:37.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:93:0)
[11:23:37.750] Timer tick, asking Buildbucket for the build status
[11:23:37.982] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:37.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:94:0) after 1m0s
[11:24:38.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:94:0)
[11:24:38.013] Timer tick, asking Buildbucket for the build status
[11:24:38.211] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:38.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:95:0) after 1m0s
[11:25:38.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:95:0)
[11:25:38.203] Timer tick, asking Buildbucket for the build status
[11:25:38.427] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:38.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:96:0) after 1m0s
[11:26:38.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:96:0)
[11:26:38.503] Timer tick, asking Buildbucket for the build status
[11:26:38.733] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:38.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:97:0) after 1m0s
[11:27:38.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:97:0)
[11:27:38.761] Timer tick, asking Buildbucket for the build status
[11:27:38.970] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:38.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:98:0) after 1m0s
[11:28:38.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:98:0)
[11:28:38.999] Timer tick, asking Buildbucket for the build status
[11:28:39.173] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:39.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:99:0) after 1m0s
[11:29:39.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:99:0)
[11:29:39.247] Timer tick, asking Buildbucket for the build status
[11:29:39.338] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:39.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:100:0) after 1m0s
[11:30:39.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:100:0)
[11:30:39.365] Timer tick, asking Buildbucket for the build status
[11:30:39.764] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:39.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:101:0) after 1m0s
[11:31:39.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:101:0)
[11:31:39.843] Timer tick, asking Buildbucket for the build status
[11:31:40.164] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:40.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:102:0) after 1m0s
[11:32:40.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:102:0)
[11:32:40.242] Timer tick, asking Buildbucket for the build status
[11:32:40.372] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:40.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:103:0) after 1m0s
[11:33:40.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:103:0)
[11:33:40.408] Timer tick, asking Buildbucket for the build status
[11:33:40.533] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:40.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:104:0) after 1m0s
[11:34:40.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:104:0)
[11:34:40.613] Timer tick, asking Buildbucket for the build status
[11:34:40.750] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:40.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:105:0) after 1m0s
[11:35:40.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:105:0)
[11:35:40.867] Timer tick, asking Buildbucket for the build status
[11:35:41.087] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:41.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:106:0) after 1m0s
[11:36:41.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:106:0)
[11:36:41.132] Timer tick, asking Buildbucket for the build status
[11:36:41.279] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:41.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:107:0) after 1m0s
[11:37:41.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:107:0)
[11:37:41.392] Timer tick, asking Buildbucket for the build status
[11:37:41.755] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:41.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:108:0) after 1m0s
[11:38:41.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:108:0)
[11:38:41.786] Timer tick, asking Buildbucket for the build status
[11:38:41.890] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:41.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:109:0) after 1m0s
[11:39:41.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:109:0)
[11:39:41.873] Timer tick, asking Buildbucket for the build status
[11:39:42.114] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:42.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:110:0) after 1m0s
[11:40:42.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:110:0)
[11:40:42.187] Timer tick, asking Buildbucket for the build status
[11:40:42.331] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:42.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:111:0) after 1m0s
[11:41:42.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:111:0)
[11:41:42.374] Timer tick, asking Buildbucket for the build status
[11:41:42.608] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:42.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:112:0) after 1m0s
[11:42:42.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:112:0)
[11:42:42.637] Timer tick, asking Buildbucket for the build status
[11:42:42.838] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:42.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:113:0) after 1m0s
[11:43:42.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:113:0)
[11:43:42.882] Timer tick, asking Buildbucket for the build status
[11:43:43.337] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:43.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:114:0) after 1m0s
[11:44:43.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:114:0)
[11:44:43.471] Timer tick, asking Buildbucket for the build status
[11:44:43.597] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:43.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:115:0) after 1m0s
[11:45:43.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:115:0)
[11:45:43.758] Timer tick, asking Buildbucket for the build status
[11:45:43.981] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:43.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:116:0) after 1m0s
[11:46:44.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:116:0)
[11:46:44.063] Timer tick, asking Buildbucket for the build status
[11:46:44.282] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:44.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:117:0) after 1m0s
[11:47:44.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:117:0)
[11:47:44.311] Timer tick, asking Buildbucket for the build status
[11:47:44.540] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:44.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:118:0) after 1m0s
[11:48:44.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:118:0)
[11:48:44.620] Timer tick, asking Buildbucket for the build status
[11:48:45.017] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:45.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:119:0) after 1m0s
[11:49:45.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:119:0)
[11:49:45.182] Timer tick, asking Buildbucket for the build status
[11:49:45.378] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:45.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:120:0) after 1m0s
[11:50:45.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:120:0)
[11:50:45.406] Timer tick, asking Buildbucket for the build status
[11:50:45.581] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:45.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:121:0) after 1m0s
[11:51:45.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:121:0)
[11:51:45.701] Timer tick, asking Buildbucket for the build status
[11:51:45.868] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:45.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:122:0) after 1m0s
[11:52:45.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:122:0)
[11:52:45.977] Timer tick, asking Buildbucket for the build status
[11:52:46.360] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:46.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:123:0) after 1m0s
[11:53:46.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:123:0)
[11:53:46.443] Timer tick, asking Buildbucket for the build status
[11:53:46.604] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:46.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:124:0) after 1m0s
[11:54:46.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:124:0)
[11:54:46.630] Timer tick, asking Buildbucket for the build status
[11:54:46.811] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:46.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:125:0) after 1m0s
[11:55:46.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:125:0)
[11:55:46.863] Timer tick, asking Buildbucket for the build status
[11:55:46.978] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:46.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:126:0) after 1m0s
[11:56:46.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:126:0)
[11:56:46.970] Timer tick, asking Buildbucket for the build status
[11:56:47.136] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:47.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:127:0) after 1m0s
[11:57:47.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:127:0)
[11:57:47.166] Timer tick, asking Buildbucket for the build status
[11:57:47.325] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:47.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:128:0) after 1m0s
[11:58:47.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:128:0)
[11:58:47.341] Timer tick, asking Buildbucket for the build status
[11:58:47.477] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:47.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:129:0) after 1m0s
[11:59:47.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:129:0)
[11:59:47.566] Timer tick, asking Buildbucket for the build status
[11:59:47.679] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:47.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:130:0) after 1m0s
[12:00:47.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:130:0)
[12:00:47.707] Timer tick, asking Buildbucket for the build status
[12:00:47.787] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:47.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:131:0) after 1m0s
[12:01:47.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:131:0)
[12:01:47.949] Timer tick, asking Buildbucket for the build status
[12:01:48.022] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:48.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:132:0) after 1m0s
[12:02:48.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:132:0)
[12:02:48.149] Timer tick, asking Buildbucket for the build status
[12:02:48.229] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:48.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:133:0) after 1m0s
[12:03:48.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:133:0)
[12:03:48.260] Timer tick, asking Buildbucket for the build status
[12:03:48.477] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:48.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:134:0) after 1m0s
[12:04:48.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:134:0)
[12:04:48.616] Timer tick, asking Buildbucket for the build status
[12:04:48.724] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:48.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:135:0) after 1m0s
[12:05:48.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:135:0)
[12:05:48.750] Timer tick, asking Buildbucket for the build status
[12:05:48.870] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:48.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:136:0) after 1m0s
[12:06:49.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:136:0)
[12:06:49.012] Timer tick, asking Buildbucket for the build status
[12:06:49.452] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:49.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:137:0) after 1m0s
[12:07:49.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:137:0)
[12:07:49.602] Timer tick, asking Buildbucket for the build status
[12:07:49.686] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:49.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:138:0) after 1m0s
[12:08:49.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:138:0)
[12:08:49.722] Timer tick, asking Buildbucket for the build status
[12:08:49.862] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:49.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:139:0) after 1m0s
[12:09:49.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:139:0)
[12:09:49.888] Timer tick, asking Buildbucket for the build status
[12:09:49.997] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:49.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:140:0) after 1m0s
[12:10:50.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:140:0)
[12:10:50.026] Timer tick, asking Buildbucket for the build status
[12:10:50.132] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:50.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:141:0) after 1m0s
[12:11:50.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:141:0)
[12:11:50.158] Timer tick, asking Buildbucket for the build status
[12:11:50.657] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:50.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:142:0) after 1m0s
[12:12:50.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:142:0)
[12:12:50.681] Timer tick, asking Buildbucket for the build status
[12:12:51.169] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:51.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:143:0) after 1m0s
[12:13:51.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:143:0)
[12:13:51.252] Timer tick, asking Buildbucket for the build status
[12:13:51.365] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:51.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:144:0) after 1m0s
[12:14:51.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:144:0)
[12:14:51.486] Timer tick, asking Buildbucket for the build status
[12:14:51.651] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:51.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:145:0) after 1m0s
[12:15:51.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:145:0)
[12:15:51.771] Timer tick, asking Buildbucket for the build status
[12:15:51.989] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:51.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:146:0) after 1m0s
[12:16:52.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:146:0)
[12:16:52.113] Timer tick, asking Buildbucket for the build status
[12:16:52.334] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:52.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:147:0) after 1m0s
[12:17:52.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:147:0)
[12:17:52.574] Timer tick, asking Buildbucket for the build status
[12:17:52.723] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:52.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:148:0) after 1m0s
[12:18:52.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:148:0)
[12:18:52.785] Timer tick, asking Buildbucket for the build status
[12:18:52.948] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:52.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:149:0) after 1m0s
[12:19:53.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:149:0)
[12:19:53.046] Timer tick, asking Buildbucket for the build status
[12:19:53.213] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:53.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:150:0) after 1m0s
[12:20:53.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:150:0)
[12:20:53.243] Timer tick, asking Buildbucket for the build status
[12:20:53.377] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:53.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:151:0) after 1m0s
[12:21:53.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:151:0)
[12:21:53.450] Timer tick, asking Buildbucket for the build status
[12:21:53.608] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:53.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:152:0) after 1m0s
[12:22:53.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:152:0)
[12:22:53.703] Timer tick, asking Buildbucket for the build status
[12:22:53.827] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:53.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:153:0) after 1m0s
[12:23:53.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:153:0)
[12:23:53.879] Timer tick, asking Buildbucket for the build status
[12:23:54.212] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:54.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:154:0) after 1m0s
[12:24:54.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:154:0)
[12:24:54.307] Timer tick, asking Buildbucket for the build status
[12:24:54.864] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:155:0) after 1m0s
[12:25:54.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:155:0)
[12:25:54.920] Timer tick, asking Buildbucket for the build status
[12:25:55.049] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:55.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:156:0) after 1m0s
[12:26:55.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:156:0)
[12:26:55.138] Timer tick, asking Buildbucket for the build status
[12:26:55.381] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:55.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:157:0) after 1m0s
[12:27:55.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:157:0)
[12:27:55.451] Timer tick, asking Buildbucket for the build status
[12:27:55.594] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:55.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:158:0) after 1m0s
[12:28:55.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:158:0)
[12:28:55.644] Timer tick, asking Buildbucket for the build status
[12:28:55.769] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:55.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:159:0) after 1m0s
[12:29:55.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:159:0)
[12:29:55.891] Timer tick, asking Buildbucket for the build status
[12:29:56.073] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:56.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:160:0) after 1m0s
[12:30:56.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:160:0)
[12:30:56.155] Timer tick, asking Buildbucket for the build status
[12:30:56.496] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:56.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:161:0) after 1m0s
[12:31:56.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:161:0)
[12:31:56.608] Timer tick, asking Buildbucket for the build status
[12:31:56.798] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:56.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:162:0) after 1m0s
[12:32:56.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:162:0)
[12:32:56.961] Timer tick, asking Buildbucket for the build status
[12:32:57.122] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:57.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:163:0) after 1m0s
[12:33:57.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:163:0)
[12:33:57.214] Timer tick, asking Buildbucket for the build status
[12:33:57.361] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:57.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:164:0) after 1m0s
[12:34:57.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:164:0)
[12:34:57.454] Timer tick, asking Buildbucket for the build status
[12:34:57.669] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:57.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:165:0) after 1m0s
[12:35:57.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:165:0)
[12:35:57.723] Timer tick, asking Buildbucket for the build status
[12:35:57.840] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:57.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:166:0) after 1m0s
[12:36:57.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:166:0)
[12:36:57.877] Timer tick, asking Buildbucket for the build status
[12:36:58.279] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:58.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:167:0) after 1m0s
[12:37:58.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:167:0)
[12:37:58.401] Timer tick, asking Buildbucket for the build status
[12:37:58.662] Build 8879519302075504336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:58.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9044949364350868768:168:0) after 1m0s
[12:38:38.696] Received PubSub notification, asking Buildbucket for the build status
[12:38:38.920] Build 8879519302075504336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:38:38.920] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1590237517452789",
"created_by": "project:chromium",
"created_ts": "1590227521785071",
"id": "8879519302075504336",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfec860f7b9a62cf226094367d7a9f93f4e38a30\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-axoi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 16545, \"got_angle_revision\": \"d3d7b95bac1957900d346637600adc9eacf1fd64\", \"got_dawn_revision\": \"65ee6497d620110546181c1dfbd0cc3064f9f7f9\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"cfec860f7b9a62cf226094367d7a9f93f4e38a30\", \"got_revision_cp\": \"refs/heads/master@{#771384}\", \"got_swarming_client_revision\": \"7e8636295f4763a5f5aace1e700b17a4af3c81b7\", \"got_swiftshader_revision\": \"cc5cda0f997d8280712920f2749bbdfe7a0f4dc3\", \"got_v8_revision\": \"414d114aaaad4f0cac357eb2705a71e3ca7bf898\", \"got_v8_revision_cp\": \"refs/heads/8.5.34@{#1}\", \"got_webrtc_revision\": \"3cc1a6509bf6143f9d52d76a7648a9c8d3bdccea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31336}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cfec860f7b9a62cf226094367d7a9f93f4e38a30\"}, \"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\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-axoi\"], \"image\": [\"chrome-win10-1703-20042500-5e6af220c3f\"], \"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\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590227524827887",
"status": "COMPLETED",
"status_changed_ts": "1590237518143000",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16545",
"builder:Windows deterministic",
"buildset:commit/git/cfec860f7b9a62cf226094367d7a9f93f4e38a30",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfec860f7b9a62cf226094367d7a9f93f4e38a30",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044949364350868768",
"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/8879519302075504336/+/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:4c59c3ddd1c48710",
"user_agent:luci-scheduler"
],
"updated_ts": "1590237518149441",
"url": "https://ci.chromium.org/b/8879519302075504336",
"utcnow_ts": "1590237518873289"
}
}
[12:38:38.920] Invocation finished in 2h46m38.68948273s with status SUCCEEDED