[12:03:50.299] New invocation is queued and will start shortly
[12:03:51.375] Starting the invocation (attempt 1)
[12:03:51.417] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:03:51.417] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:03:51.417] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072029563014875264",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ef20a099a86561da0b57469aaba148829eea37f6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9072029563014875264",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/ef20a099a86561da0b57469aaba148829eea37f6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef20a099a86561da0b57469aaba148829eea37f6",
"gitiles_ref:refs/heads/master"
]
}
[12:03:54.507] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564401831596597",
"id": "8906599500990845472",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ef20a099a86561da0b57469aaba148829eea37f6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564401832331465",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14276",
"builder:Windows deterministic",
"buildset:commit/git/ef20a099a86561da0b57469aaba148829eea37f6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef20a099a86561da0b57469aaba148829eea37f6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072029563014875264",
"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/8906599500990845472/+/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": "1564401832331610",
"url": "https://ci.chromium.org/b/8906599500990845472",
"utcnow_ts": "1564401834493555"
}
}
[12:03:54.507] Task URL: https://ci.chromium.org/b/8906599500990845472
[12:03:54.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:2:0) after 1m0s
[12:03:55.962] Received PubSub notification, asking Buildbucket for the build status
[12:03:56.311] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:54.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:2:0)
[12:04:54.617] Timer tick, asking Buildbucket for the build status
[12:04:55.703] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:55.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:4:0) after 1m0s
[12:05:55.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:4:0)
[12:05:55.814] Timer tick, asking Buildbucket for the build status
[12:05:56.443] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:56.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:5:0) after 1m0s
[12:06:56.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:5:0)
[12:06:56.491] Timer tick, asking Buildbucket for the build status
[12:06:57.390] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:57.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:6:0) after 1m0s
[12:07:57.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:6:0)
[12:07:57.415] Timer tick, asking Buildbucket for the build status
[12:07:57.547] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:57.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:7:0) after 1m0s
[12:08:57.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:7:0)
[12:08:57.576] Timer tick, asking Buildbucket for the build status
[12:08:59.230] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:8:0) after 1m0s
[12:09:59.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:8:0)
[12:09:59.254] Timer tick, asking Buildbucket for the build status
[12:09:59.520] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:59.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:9:0) after 1m0s
[12:10:59.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:9:0)
[12:10:59.548] Timer tick, asking Buildbucket for the build status
[12:10:59.820] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:59.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:10:0) after 1m0s
[12:11:59.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:10:0)
[12:11:59.847] Timer tick, asking Buildbucket for the build status
[12:12:00.040] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:00.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:11:0) after 1m0s
[12:13:00.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:11:0)
[12:13:00.145] Timer tick, asking Buildbucket for the build status
[12:13:00.361] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:00.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:12:0) after 1m0s
[12:14:00.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:12:0)
[12:14:00.362] Timer tick, asking Buildbucket for the build status
[12:14:01.618] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:01.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:13:0) after 1m0s
[12:15:01.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:13:0)
[12:15:01.659] Timer tick, asking Buildbucket for the build status
[12:15:01.855] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:01.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:14:0) after 1m0s
[12:16:02.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:14:0)
[12:16:02.147] Timer tick, asking Buildbucket for the build status
[12:16:02.683] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:02.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:15:0) after 1m0s
[12:17:02.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:15:0)
[12:17:02.748] Timer tick, asking Buildbucket for the build status
[12:17:02.932] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:02.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:16:0) after 1m0s
[12:18:02.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:16:0)
[12:18:02.975] Timer tick, asking Buildbucket for the build status
[12:18:03.265] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:03.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:17:0) after 1m0s
[12:19:03.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:17:0)
[12:19:03.379] Timer tick, asking Buildbucket for the build status
[12:19:06.818] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:06.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:18:0) after 1m0s
[12:20:06.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:18:0)
[12:20:06.888] Timer tick, asking Buildbucket for the build status
[12:20:07.078] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:07.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:19:0) after 1m0s
[12:21:07.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:19:0)
[12:21:07.130] Timer tick, asking Buildbucket for the build status
[12:21:07.373] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:07.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:20:0) after 1m0s
[12:22:07.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:20:0)
[12:22:07.494] Timer tick, asking Buildbucket for the build status
[12:22:07.678] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:07.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:21:0) after 1m0s
[12:23:07.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:21:0)
[12:23:07.712] Timer tick, asking Buildbucket for the build status
[12:23:07.903] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:07.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:22:0) after 1m0s
[12:24:08.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:22:0)
[12:24:08.009] Timer tick, asking Buildbucket for the build status
[12:24:08.302] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:08.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:23:0) after 1m0s
[12:25:08.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:23:0)
[12:25:08.325] Timer tick, asking Buildbucket for the build status
[12:25:08.467] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:08.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:24:0) after 1m0s
[12:26:08.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:24:0)
[12:26:08.688] Timer tick, asking Buildbucket for the build status
[12:26:09.192] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:09.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:25:0) after 1m0s
[12:27:09.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:25:0)
[12:27:09.254] Timer tick, asking Buildbucket for the build status
[12:27:11.866] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:11.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:26:0) after 1m0s
[12:28:12.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:26:0)
[12:28:12.011] Timer tick, asking Buildbucket for the build status
[12:28:13.751] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:27:0) after 1m0s
[12:29:13.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:27:0)
[12:29:13.822] Timer tick, asking Buildbucket for the build status
[12:29:16.248] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:16.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:28:0) after 1m0s
[12:30:16.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:28:0)
[12:30:16.311] Timer tick, asking Buildbucket for the build status
[12:30:16.607] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:16.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:29:0) after 1m0s
[12:31:16.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:29:0)
[12:31:16.684] Timer tick, asking Buildbucket for the build status
[12:31:16.966] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:30:0) after 1m0s
[12:32:16.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:30:0)
[12:32:16.991] Timer tick, asking Buildbucket for the build status
[12:32:17.355] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:17.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:31:0) after 1m0s
[12:33:17.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:31:0)
[12:33:17.419] Timer tick, asking Buildbucket for the build status
[12:33:17.613] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:17.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:32:0) after 1m0s
[12:34:17.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:32:0)
[12:34:17.635] Timer tick, asking Buildbucket for the build status
[12:34:18.147] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:33:0) after 1m0s
[12:35:18.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:33:0)
[12:35:18.183] Timer tick, asking Buildbucket for the build status
[12:35:18.385] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:18.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:34:0) after 1m0s
[12:36:18.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:34:0)
[12:36:18.436] Timer tick, asking Buildbucket for the build status
[12:36:19.009] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:19.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:35:0) after 1m0s
[12:37:19.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:35:0)
[12:37:19.037] Timer tick, asking Buildbucket for the build status
[12:37:19.287] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:19.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:36:0) after 1m0s
[12:38:19.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:36:0)
[12:38:19.371] Timer tick, asking Buildbucket for the build status
[12:38:19.933] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:19.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:37:0) after 1m0s
[12:39:19.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:37:0)
[12:39:19.986] Timer tick, asking Buildbucket for the build status
[12:39:20.158] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:20.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:38:0) after 1m0s
[12:40:20.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:38:0)
[12:40:20.220] Timer tick, asking Buildbucket for the build status
[12:40:21.515] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:21.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:39:0) after 1m0s
[12:41:21.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:39:0)
[12:41:21.675] Timer tick, asking Buildbucket for the build status
[12:41:22.434] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:22.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:40:0) after 1m0s
[12:42:22.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:40:0)
[12:42:22.454] Timer tick, asking Buildbucket for the build status
[12:42:23.142] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:23.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:41:0) after 1m0s
[12:43:23.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:41:0)
[12:43:23.230] Timer tick, asking Buildbucket for the build status
[12:43:23.614] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:23.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:42:0) after 1m0s
[12:44:23.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:42:0)
[12:44:23.648] Timer tick, asking Buildbucket for the build status
[12:44:23.786] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:23.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:43:0) after 1m0s
[12:45:23.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:43:0)
[12:45:23.832] Timer tick, asking Buildbucket for the build status
[12:45:24.055] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:24.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:44:0) after 1m0s
[12:46:24.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:44:0)
[12:46:24.086] Timer tick, asking Buildbucket for the build status
[12:46:24.778] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:24.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:45:0) after 1m0s
[12:47:24.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:45:0)
[12:47:24.848] Timer tick, asking Buildbucket for the build status
[12:47:25.016] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:25.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:46:0) after 1m0s
[12:48:25.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:46:0)
[12:48:25.193] Timer tick, asking Buildbucket for the build status
[12:48:25.629] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:25.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:47:0) after 1m0s
[12:49:25.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:47:0)
[12:49:25.803] Timer tick, asking Buildbucket for the build status
[12:49:26.208] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:26.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:48:0) after 1m0s
[12:50:26.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:48:0)
[12:50:26.220] Timer tick, asking Buildbucket for the build status
[12:50:26.397] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:26.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:49:0) after 1m0s
[12:51:26.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:49:0)
[12:51:26.432] Timer tick, asking Buildbucket for the build status
[12:51:26.989] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:26.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:50:0) after 1m0s
[12:52:27.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:50:0)
[12:52:27.021] Timer tick, asking Buildbucket for the build status
[12:52:27.592] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:27.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:51:0) after 1m0s
[12:53:27.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:51:0)
[12:53:27.618] Timer tick, asking Buildbucket for the build status
[12:53:28.071] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:28.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:52:0) after 1m0s
[12:54:28.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:52:0)
[12:54:28.100] Timer tick, asking Buildbucket for the build status
[12:54:28.454] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:28.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:53:0) after 1m0s
[12:55:28.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:53:0)
[12:55:28.485] Timer tick, asking Buildbucket for the build status
[12:55:28.664] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:28.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:54:0) after 1m0s
[12:56:28.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:54:0)
[12:56:28.720] Timer tick, asking Buildbucket for the build status
[12:56:32.467] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:32.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:55:0) after 1m0s
[12:57:32.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:55:0)
[12:57:32.497] Timer tick, asking Buildbucket for the build status
[12:57:32.779] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:32.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:56:0) after 1m0s
[12:58:32.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:56:0)
[12:58:32.782] Timer tick, asking Buildbucket for the build status
[12:58:34.196] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:34.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:57:0) after 1m0s
[12:59:34.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:57:0)
[12:59:34.273] Timer tick, asking Buildbucket for the build status
[12:59:34.932] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:34.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:58:0) after 1m0s
[13:00:35.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:58:0)
[13:00:35.027] Timer tick, asking Buildbucket for the build status
[13:00:35.521] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:35.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:59:0) after 1m0s
[13:01:35.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:59:0)
[13:01:35.591] Timer tick, asking Buildbucket for the build status
[13:01:35.779] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:35.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:60:0) after 1m0s
[13:02:35.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:60:0)
[13:02:35.825] Timer tick, asking Buildbucket for the build status
[13:02:36.035] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:36.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:61:0) after 1m0s
[13:03:36.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:61:0)
[13:03:36.123] Timer tick, asking Buildbucket for the build status
[13:03:36.884] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:36.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:62:0) after 1m0s
[13:04:36.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:62:0)
[13:04:36.907] Timer tick, asking Buildbucket for the build status
[13:04:38.318] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:63:0) after 1m0s
[13:05:38.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:63:0)
[13:05:38.356] Timer tick, asking Buildbucket for the build status
[13:05:39.993] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:39.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:64:0) after 1m0s
[13:06:40.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:64:0)
[13:06:40.023] Timer tick, asking Buildbucket for the build status
[13:06:40.165] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:40.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:65:0) after 1m0s
[13:07:40.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:65:0)
[13:07:40.188] Timer tick, asking Buildbucket for the build status
[13:07:40.681] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:40.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:66:0) after 1m0s
[13:08:40.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:66:0)
[13:08:40.736] Timer tick, asking Buildbucket for the build status
[13:08:41.062] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:41.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:67:0) after 1m0s
[13:09:41.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:67:0)
[13:09:41.093] Timer tick, asking Buildbucket for the build status
[13:09:41.323] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:41.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:68:0) after 1m0s
[13:10:41.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:68:0)
[13:10:41.298] Timer tick, asking Buildbucket for the build status
[13:10:42.453] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:42.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:69:0) after 1m0s
[13:11:42.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:69:0)
[13:11:42.530] Timer tick, asking Buildbucket for the build status
[13:11:42.992] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:42.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:70:0) after 1m0s
[13:12:43.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:70:0)
[13:12:43.083] Timer tick, asking Buildbucket for the build status
[13:12:43.510] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:43.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:71:0) after 1m0s
[13:13:43.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:71:0)
[13:13:43.618] Timer tick, asking Buildbucket for the build status
[13:13:43.889] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:43.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:72:0) after 1m0s
[13:14:43.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:72:0)
[13:14:43.950] Timer tick, asking Buildbucket for the build status
[13:14:44.221] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:44.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:73:0) after 1m0s
[13:15:44.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:73:0)
[13:15:44.257] Timer tick, asking Buildbucket for the build status
[13:15:44.522] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:44.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:74:0) after 1m0s
[13:16:44.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:74:0)
[13:16:44.575] Timer tick, asking Buildbucket for the build status
[13:16:44.762] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:44.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:75:0) after 1m0s
[13:17:44.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:75:0)
[13:17:44.788] Timer tick, asking Buildbucket for the build status
[13:17:45.743] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:45.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:76:0) after 1m0s
[13:18:45.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:76:0)
[13:18:45.767] Timer tick, asking Buildbucket for the build status
[13:18:46.009] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:46.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:77:0) after 1m0s
[13:19:46.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:77:0)
[13:19:46.041] Timer tick, asking Buildbucket for the build status
[13:19:46.315] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:46.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:78:0) after 1m0s
[13:20:46.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:78:0)
[13:20:46.422] Timer tick, asking Buildbucket for the build status
[13:20:46.641] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:46.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:79:0) after 1m0s
[13:21:46.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:79:0)
[13:21:46.748] Timer tick, asking Buildbucket for the build status
[13:21:47.017] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:47.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:80:0) after 1m0s
[13:22:47.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:80:0)
[13:22:47.127] Timer tick, asking Buildbucket for the build status
[13:22:47.590] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:47.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:81:0) after 1m0s
[13:23:47.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:81:0)
[13:23:47.799] Timer tick, asking Buildbucket for the build status
[13:23:48.114] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:48.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:82:0) after 1m0s
[13:24:48.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:82:0)
[13:24:48.151] Timer tick, asking Buildbucket for the build status
[13:24:48.430] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:48.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:83:0) after 1m0s
[13:25:48.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:83:0)
[13:25:48.506] Timer tick, asking Buildbucket for the build status
[13:25:48.846] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:48.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:84:0) after 1m0s
[13:26:48.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:84:0)
[13:26:48.896] Timer tick, asking Buildbucket for the build status
[13:26:49.527] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:49.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:85:0) after 1m0s
[13:27:49.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:85:0)
[13:27:49.537] Timer tick, asking Buildbucket for the build status
[13:27:49.814] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:49.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:86:0) after 1m0s
[13:28:49.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:86:0)
[13:28:49.867] Timer tick, asking Buildbucket for the build status
[13:28:50.223] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:50.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:87:0) after 1m0s
[13:29:50.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:87:0)
[13:29:50.304] Timer tick, asking Buildbucket for the build status
[13:29:50.461] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:50.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:88:0) after 1m0s
[13:30:50.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:88:0)
[13:30:50.630] Timer tick, asking Buildbucket for the build status
[13:30:50.851] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:50.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:89:0) after 1m0s
[13:31:50.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:89:0)
[13:31:50.932] Timer tick, asking Buildbucket for the build status
[13:31:52.652] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:90:0) after 1m0s
[13:32:52.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:90:0)
[13:32:52.870] Timer tick, asking Buildbucket for the build status
[13:32:53.120] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:53.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:91:0) after 1m0s
[13:33:53.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:91:0)
[13:33:53.185] Timer tick, asking Buildbucket for the build status
[13:33:54.556] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:54.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:92:0) after 1m0s
[13:34:54.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:92:0)
[13:34:54.694] Timer tick, asking Buildbucket for the build status
[13:34:54.910] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:54.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:93:0) after 1m0s
[13:35:55.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:93:0)
[13:35:55.043] Timer tick, asking Buildbucket for the build status
[13:35:55.313] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:55.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:94:0) after 1m0s
[13:36:55.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:94:0)
[13:36:55.349] Timer tick, asking Buildbucket for the build status
[13:36:55.518] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:55.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:95:0) after 1m0s
[13:37:55.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:95:0)
[13:37:55.604] Timer tick, asking Buildbucket for the build status
[13:37:57.182] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:57.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:96:0) after 1m0s
[13:38:57.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:96:0)
[13:38:57.210] Timer tick, asking Buildbucket for the build status
[13:38:57.508] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:57.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:97:0) after 1m0s
[13:39:57.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:97:0)
[13:39:57.585] Timer tick, asking Buildbucket for the build status
[13:39:57.721] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:57.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:98:0) after 1m0s
[13:40:57.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:98:0)
[13:40:57.709] Timer tick, asking Buildbucket for the build status
[13:40:59.922] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:59.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:99:0) after 1m0s
[13:41:59.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:99:0)
[13:41:59.950] Timer tick, asking Buildbucket for the build status
[13:42:00.134] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:00.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:100:0) after 1m0s
[13:43:00.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:100:0)
[13:43:00.170] Timer tick, asking Buildbucket for the build status
[13:43:00.489] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:00.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:101:0) after 1m0s
[13:44:00.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:101:0)
[13:44:00.516] Timer tick, asking Buildbucket for the build status
[13:44:01.201] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:01.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:102:0) after 1m0s
[13:45:01.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:102:0)
[13:45:01.286] Timer tick, asking Buildbucket for the build status
[13:45:01.868] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:01.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:103:0) after 1m0s
[13:46:01.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:103:0)
[13:46:01.868] Timer tick, asking Buildbucket for the build status
[13:46:04.197] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:04.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:104:0) after 1m0s
[13:47:04.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:104:0)
[13:47:04.232] Timer tick, asking Buildbucket for the build status
[13:47:04.648] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:04.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:105:0) after 1m0s
[13:48:04.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:105:0)
[13:48:04.729] Timer tick, asking Buildbucket for the build status
[13:48:05.049] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:05.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:106:0) after 1m0s
[13:49:05.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:106:0)
[13:49:05.079] Timer tick, asking Buildbucket for the build status
[13:49:07.940] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:07.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:107:0) after 1m0s
[13:50:07.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:107:0)
[13:50:07.964] Timer tick, asking Buildbucket for the build status
[13:50:08.119] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:08.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:108:0) after 1m0s
[13:51:08.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:108:0)
[13:51:08.192] Timer tick, asking Buildbucket for the build status
[13:51:11.293] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:11.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:109:0) after 1m0s
[13:52:11.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:109:0)
[13:52:11.353] Timer tick, asking Buildbucket for the build status
[13:52:11.763] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:11.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:110:0) after 1m0s
[13:53:11.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:110:0)
[13:53:11.848] Timer tick, asking Buildbucket for the build status
[13:53:13.919] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:13.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:111:0) after 1m0s
[13:54:14.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:111:0)
[13:54:14.045] Timer tick, asking Buildbucket for the build status
[13:54:15.810] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:15.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:112:0) after 1m0s
[13:55:15.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:112:0)
[13:55:15.901] Timer tick, asking Buildbucket for the build status
[13:55:16.547] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:16.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:113:0) after 1m0s
[13:56:16.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:113:0)
[13:56:16.741] Timer tick, asking Buildbucket for the build status
[13:56:17.319] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:17.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:114:0) after 1m0s
[13:57:17.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:114:0)
[13:57:17.426] Timer tick, asking Buildbucket for the build status
[13:57:17.871] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:17.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:115:0) after 1m0s
[13:58:18.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:115:0)
[13:58:18.055] Timer tick, asking Buildbucket for the build status
[13:58:18.665] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:18.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:116:0) after 1m0s
[13:59:18.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:116:0)
[13:59:18.794] Timer tick, asking Buildbucket for the build status
[13:59:20.082] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:20.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:117:0) after 1m0s
[14:00:20.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:117:0)
[14:00:20.330] Timer tick, asking Buildbucket for the build status
[14:00:20.761] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:20.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:118:0) after 1m0s
[14:01:20.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:118:0)
[14:01:20.825] Timer tick, asking Buildbucket for the build status
[14:01:21.166] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:21.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:119:0) after 1m0s
[14:02:21.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:119:0)
[14:02:21.179] Timer tick, asking Buildbucket for the build status
[14:02:21.635] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:21.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:120:0) after 1m0s
[14:03:21.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:120:0)
[14:03:21.668] Timer tick, asking Buildbucket for the build status
[14:03:22.314] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:22.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:121:0) after 1m0s
[14:04:22.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:121:0)
[14:04:22.363] Timer tick, asking Buildbucket for the build status
[14:04:23.162] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:23.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:122:0) after 1m0s
[14:05:23.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:122:0)
[14:05:23.211] Timer tick, asking Buildbucket for the build status
[14:05:23.838] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:23.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:123:0) after 1m0s
[14:06:23.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:123:0)
[14:06:23.866] Timer tick, asking Buildbucket for the build status
[14:06:24.620] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:24.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:124:0) after 1m0s
[14:07:24.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:124:0)
[14:07:24.651] Timer tick, asking Buildbucket for the build status
[14:07:24.981] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:24.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:125:0) after 1m0s
[14:08:24.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:125:0)
[14:08:24.982] Timer tick, asking Buildbucket for the build status
[14:08:25.297] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:25.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:126:0) after 1m0s
[14:09:25.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:126:0)
[14:09:25.321] Timer tick, asking Buildbucket for the build status
[14:09:26.057] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:26.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:127:0) after 1m0s
[14:10:26.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:127:0)
[14:10:26.086] Timer tick, asking Buildbucket for the build status
[14:10:27.707] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:27.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:128:0) after 1m0s
[14:11:27.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:128:0)
[14:11:27.768] Timer tick, asking Buildbucket for the build status
[14:11:28.607] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:28.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:129:0) after 1m0s
[14:12:28.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:129:0)
[14:12:28.941] Timer tick, asking Buildbucket for the build status
[14:12:29.352] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:29.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:130:0) after 1m0s
[14:13:29.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:130:0)
[14:13:29.478] Timer tick, asking Buildbucket for the build status
[14:13:29.727] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:29.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:131:0) after 1m0s
[14:14:29.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:131:0)
[14:14:29.806] Timer tick, asking Buildbucket for the build status
[14:14:30.118] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:30.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:132:0) after 1m0s
[14:15:30.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:132:0)
[14:15:30.215] Timer tick, asking Buildbucket for the build status
[14:15:30.418] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:30.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:133:0) after 1m0s
[14:16:30.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:133:0)
[14:16:30.516] Timer tick, asking Buildbucket for the build status
[14:16:30.896] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:30.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:134:0) after 1m0s
[14:17:30.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:134:0)
[14:17:30.988] Timer tick, asking Buildbucket for the build status
[14:17:34.138] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:34.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:135:0) after 1m0s
[14:18:34.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:135:0)
[14:18:34.180] Timer tick, asking Buildbucket for the build status
[14:18:34.296] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:34.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:136:0) after 1m0s
[14:19:34.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:136:0)
[14:19:34.284] Timer tick, asking Buildbucket for the build status
[14:19:34.808] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:34.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:137:0) after 1m0s
[14:20:34.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:137:0)
[14:20:34.883] Timer tick, asking Buildbucket for the build status
[14:20:35.226] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:35.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:138:0) after 1m0s
[14:21:35.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:138:0)
[14:21:35.256] Timer tick, asking Buildbucket for the build status
[14:21:36.627] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:36.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:139:0) after 1m0s
[14:22:36.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:139:0)
[14:22:36.781] Timer tick, asking Buildbucket for the build status
[14:22:38.388] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:38.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:140:0) after 1m0s
[14:23:38.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:140:0)
[14:23:38.790] Timer tick, asking Buildbucket for the build status
[14:23:38.948] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:38.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:141:0) after 1m0s
[14:24:39.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:141:0)
[14:24:39.113] Timer tick, asking Buildbucket for the build status
[14:24:39.518] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:39.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:142:0) after 1m0s
[14:25:39.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:142:0)
[14:25:39.649] Timer tick, asking Buildbucket for the build status
[14:25:39.844] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:39.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:143:0) after 1m0s
[14:26:39.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:143:0)
[14:26:39.984] Timer tick, asking Buildbucket for the build status
[14:26:42.726] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:42.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:144:0) after 1m0s
[14:27:42.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:144:0)
[14:27:42.948] Timer tick, asking Buildbucket for the build status
[14:27:43.336] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:43.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:145:0) after 1m0s
[14:28:43.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:145:0)
[14:28:43.389] Timer tick, asking Buildbucket for the build status
[14:28:45.011] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:45.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:146:0) after 1m0s
[14:29:45.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:146:0)
[14:29:45.095] Timer tick, asking Buildbucket for the build status
[14:29:45.308] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:45.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:147:0) after 1m0s
[14:30:45.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:147:0)
[14:30:45.345] Timer tick, asking Buildbucket for the build status
[14:30:46.134] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:46.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:148:0) after 1m0s
[14:31:46.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:148:0)
[14:31:46.313] Timer tick, asking Buildbucket for the build status
[14:31:46.525] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:46.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:149:0) after 1m0s
[14:32:46.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:149:0)
[14:32:46.607] Timer tick, asking Buildbucket for the build status
[14:32:47.126] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:47.126] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:150:0) after 1m0s
[14:33:47.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:150:0)
[14:33:47.247] Timer tick, asking Buildbucket for the build status
[14:33:48.833] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:48.833] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:151:0) after 1m0s
[14:34:48.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:151:0)
[14:34:48.916] Timer tick, asking Buildbucket for the build status
[14:34:49.100] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:49.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:152:0) after 1m0s
[14:35:49.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:152:0)
[14:35:49.151] Timer tick, asking Buildbucket for the build status
[14:35:50.895] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:50.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:153:0) after 1m0s
[14:36:50.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:153:0)
[14:36:50.926] Timer tick, asking Buildbucket for the build status
[14:36:51.065] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:51.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:154:0) after 1m0s
[14:37:51.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:154:0)
[14:37:51.127] Timer tick, asking Buildbucket for the build status
[14:37:51.503] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:51.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:155:0) after 1m0s
[14:38:51.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:155:0)
[14:38:51.584] Timer tick, asking Buildbucket for the build status
[14:38:52.150] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:52.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:156:0) after 1m0s
[14:39:52.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:156:0)
[14:39:52.236] Timer tick, asking Buildbucket for the build status
[14:39:53.286] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:53.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:157:0) after 1m0s
[14:40:53.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:157:0)
[14:40:53.284] Timer tick, asking Buildbucket for the build status
[14:40:53.562] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:53.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:158:0) after 1m0s
[14:41:53.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:158:0)
[14:41:53.682] Timer tick, asking Buildbucket for the build status
[14:41:57.513] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:57.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:159:0) after 1m0s
[14:42:57.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:159:0)
[14:42:57.593] Timer tick, asking Buildbucket for the build status
[14:42:58.129] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:58.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:160:0) after 1m0s
[14:43:58.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:160:0)
[14:43:58.186] Timer tick, asking Buildbucket for the build status
[14:43:58.418] Build 8906599500990845472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:58.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9072029563014875264:161:0) after 1m0s
[14:44:48.476] Received PubSub notification, asking Buildbucket for the build status
[14:44:48.904] Build 8906599500990845472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:44:48.904] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564411487643314",
"created_by": "project:chromium",
"created_ts": "1564401831596597",
"id": "8906599500990845472",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ef20a099a86561da0b57469aaba148829eea37f6\"}}",
"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-03yq\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14276, \"got_angle_revision\": \"c405776eb4a0cd4fbebff99f658527981e9d33a3\", \"got_dawn_revision\": \"b98f0faa4d0ba55fcde794fe0e6fcb069e43d8c3\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"ef20a099a86561da0b57469aaba148829eea37f6\", \"got_revision_cp\": \"refs/heads/master@{#681774}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9789d9e4e8d863a5c4f3354bf226971a30192928\", \"got_v8_revision_cp\": \"refs/heads/7.8.1@{#1}\", \"got_webrtc_revision\": \"ed0febf57383ad406974a33fe72917f2f42f1a69\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28696}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ef20a099a86561da0b57469aaba148829eea37f6\"}, \"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-03yq\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"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\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564401834202676",
"status": "COMPLETED",
"status_changed_ts": "1564411488098534",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14276",
"builder:Windows deterministic",
"buildset:commit/git/ef20a099a86561da0b57469aaba148829eea37f6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef20a099a86561da0b57469aaba148829eea37f6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072029563014875264",
"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/8906599500990845472/+/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:46566f1b2e04f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1564411488124109",
"url": "https://ci.chromium.org/b/8906599500990845472",
"utcnow_ts": "1564411488894810"
}
}
[14:44:48.904] Invocation finished in 2h40m58.622343089s with status SUCCEEDED