[13:40:04.578] New invocation is queued and will start shortly
[13:40:05.671] Starting the invocation (attempt 1)
[13:40:05.705] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:40:05.705] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:40:05.705] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058615157217372832",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a1848663f783c60fe19ccbd8808d1ae539473797\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9058615157217372832",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/a1848663f783c60fe19ccbd8808d1ae539473797",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1848663f783c60fe19ccbd8808d1ae539473797",
"gitiles_ref:refs/heads/master"
]
}
[13:40:06.642] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577194805908310",
"id": "8893185095158728912",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a1848663f783c60fe19ccbd8808d1ae539473797\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577194806437396",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15531",
"builder:Windows deterministic",
"buildset:commit/git/a1848663f783c60fe19ccbd8808d1ae539473797",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1848663f783c60fe19ccbd8808d1ae539473797",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058615157217372832",
"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/8893185095158728912/+/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": "1577194806437514",
"url": "https://ci.chromium.org/b/8893185095158728912",
"utcnow_ts": "1577194806632443"
}
}
[13:40:06.642] Task URL: https://ci.chromium.org/b/8893185095158728912
[13:40:06.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:2:0) after 1m0s
[13:40:17.270] Received PubSub notification, asking Buildbucket for the build status
[13:40:17.405] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:06.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:2:0)
[13:41:06.664] Timer tick, asking Buildbucket for the build status
[13:41:07.639] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:07.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:4:0) after 1m0s
[13:42:07.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:4:0)
[13:42:07.658] Timer tick, asking Buildbucket for the build status
[13:42:08.354] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:08.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:5:0) after 1m0s
[13:43:08.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:5:0)
[13:43:08.449] Timer tick, asking Buildbucket for the build status
[13:43:08.627] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:08.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:6:0) after 1m0s
[13:44:08.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:6:0)
[13:44:08.649] Timer tick, asking Buildbucket for the build status
[13:44:08.843] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:08.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:7:0) after 1m0s
[13:45:08.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:7:0)
[13:45:08.864] Timer tick, asking Buildbucket for the build status
[13:45:09.247] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:09.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:8:0) after 1m0s
[13:46:09.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:8:0)
[13:46:09.264] Timer tick, asking Buildbucket for the build status
[13:46:10.069] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:10.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:9:0) after 1m0s
[13:47:10.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:9:0)
[13:47:10.094] Timer tick, asking Buildbucket for the build status
[13:47:10.304] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:10.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:10:0) after 1m0s
[13:48:10.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:10:0)
[13:48:10.380] Timer tick, asking Buildbucket for the build status
[13:48:10.589] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:10.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:11:0) after 1m0s
[13:49:10.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:11:0)
[13:49:10.635] Timer tick, asking Buildbucket for the build status
[13:49:10.964] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:10.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:12:0) after 1m0s
[13:50:10.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:12:0)
[13:50:10.985] Timer tick, asking Buildbucket for the build status
[13:50:11.531] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:11.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:13:0) after 1m0s
[13:51:11.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:13:0)
[13:51:11.635] Timer tick, asking Buildbucket for the build status
[13:51:12.109] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:12.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:14:0) after 1m0s
[13:52:12.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:14:0)
[13:52:12.136] Timer tick, asking Buildbucket for the build status
[13:52:12.519] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:12.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:15:0) after 1m0s
[13:53:12.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:15:0)
[13:53:12.539] Timer tick, asking Buildbucket for the build status
[13:53:12.702] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:12.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:16:0) after 1m0s
[13:54:12.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:16:0)
[13:54:12.751] Timer tick, asking Buildbucket for the build status
[13:54:12.893] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:12.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:17:0) after 1m0s
[13:55:12.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:17:0)
[13:55:12.913] Timer tick, asking Buildbucket for the build status
[13:55:13.460] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:13.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:18:0) after 1m0s
[13:56:13.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:18:0)
[13:56:13.438] Timer tick, asking Buildbucket for the build status
[13:56:13.667] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:13.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:19:0) after 1m0s
[13:57:13.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:19:0)
[13:57:13.743] Timer tick, asking Buildbucket for the build status
[13:57:15.454] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:15.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:20:0) after 1m0s
[13:58:15.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:20:0)
[13:58:15.512] Timer tick, asking Buildbucket for the build status
[13:58:15.665] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:15.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:21:0) after 1m0s
[13:59:15.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:21:0)
[13:59:15.662] Timer tick, asking Buildbucket for the build status
[13:59:15.858] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:15.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:22:0) after 1m0s
[14:00:15.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:22:0)
[14:00:15.878] Timer tick, asking Buildbucket for the build status
[14:00:16.133] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:16.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:23:0) after 1m0s
[14:01:16.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:23:0)
[14:01:16.153] Timer tick, asking Buildbucket for the build status
[14:01:16.353] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:16.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:24:0) after 1m0s
[14:02:16.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:24:0)
[14:02:16.536] Timer tick, asking Buildbucket for the build status
[14:02:17.224] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:17.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:25:0) after 1m0s
[14:03:17.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:25:0)
[14:03:17.243] Timer tick, asking Buildbucket for the build status
[14:03:17.667] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:17.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:26:0) after 1m0s
[14:04:17.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:26:0)
[14:04:17.727] Timer tick, asking Buildbucket for the build status
[14:04:18.173] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:18.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:27:0) after 1m0s
[14:05:18.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:27:0)
[14:05:18.280] Timer tick, asking Buildbucket for the build status
[14:05:18.394] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:18.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:28:0) after 1m0s
[14:06:18.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:28:0)
[14:06:18.605] Timer tick, asking Buildbucket for the build status
[14:06:18.979] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:18.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:29:0) after 1m0s
[14:07:19.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:29:0)
[14:07:19.062] Timer tick, asking Buildbucket for the build status
[14:07:19.796] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:19.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:30:0) after 1m0s
[14:08:19.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:30:0)
[14:08:19.905] Timer tick, asking Buildbucket for the build status
[14:08:20.171] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:20.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:31:0) after 1m0s
[14:09:20.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:31:0)
[14:09:20.181] Timer tick, asking Buildbucket for the build status
[14:09:20.373] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:20.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:32:0) after 1m0s
[14:10:20.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:32:0)
[14:10:20.539] Timer tick, asking Buildbucket for the build status
[14:10:21.028] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:21.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:33:0) after 1m0s
[14:11:21.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:33:0)
[14:11:21.152] Timer tick, asking Buildbucket for the build status
[14:11:21.600] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:21.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:34:0) after 1m0s
[14:12:21.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:34:0)
[14:12:21.714] Timer tick, asking Buildbucket for the build status
[14:12:21.896] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:21.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:35:0) after 1m0s
[14:13:22.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:35:0)
[14:13:22.018] Timer tick, asking Buildbucket for the build status
[14:13:22.270] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:22.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:36:0) after 1m0s
[14:14:22.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:36:0)
[14:14:22.364] Timer tick, asking Buildbucket for the build status
[14:14:22.778] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:22.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:37:0) after 1m0s
[14:15:22.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:37:0)
[14:15:22.801] Timer tick, asking Buildbucket for the build status
[14:15:23.001] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:23.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:38:0) after 1m0s
[14:16:22.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:38:0)
[14:16:22.994] Timer tick, asking Buildbucket for the build status
[14:16:23.256] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:23.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:39:0) after 1m0s
[14:17:23.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:39:0)
[14:17:23.307] Timer tick, asking Buildbucket for the build status
[14:17:23.581] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:23.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:40:0) after 1m0s
[14:18:23.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:40:0)
[14:18:23.664] Timer tick, asking Buildbucket for the build status
[14:18:23.895] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:23.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:41:0) after 1m0s
[14:19:24.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:41:0)
[14:19:24.078] Timer tick, asking Buildbucket for the build status
[14:19:24.272] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:24.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:42:0) after 1m0s
[14:20:24.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:42:0)
[14:20:24.314] Timer tick, asking Buildbucket for the build status
[14:20:25.012] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:25.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:43:0) after 1m0s
[14:21:24.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:43:0)
[14:21:24.985] Timer tick, asking Buildbucket for the build status
[14:21:25.867] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:25.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:44:0) after 1m0s
[14:22:26.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:44:0)
[14:22:26.120] Timer tick, asking Buildbucket for the build status
[14:22:26.251] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:26.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:45:0) after 1m0s
[14:23:26.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:45:0)
[14:23:26.274] Timer tick, asking Buildbucket for the build status
[14:23:26.535] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:26.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:46:0) after 1m0s
[14:24:26.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:46:0)
[14:24:26.588] Timer tick, asking Buildbucket for the build status
[14:24:26.730] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:26.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:47:0) after 1m0s
[14:25:26.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:47:0)
[14:25:26.760] Timer tick, asking Buildbucket for the build status
[14:25:27.040] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:27.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:48:0) after 1m0s
[14:26:27.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:48:0)
[14:26:27.109] Timer tick, asking Buildbucket for the build status
[14:26:27.349] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:49:0) after 1m0s
[14:27:27.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:49:0)
[14:27:27.569] Timer tick, asking Buildbucket for the build status
[14:27:28.170] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:28.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:50:0) after 1m0s
[14:28:28.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:50:0)
[14:28:28.231] Timer tick, asking Buildbucket for the build status
[14:28:28.400] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:28.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:51:0) after 1m0s
[14:29:28.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:51:0)
[14:29:28.427] Timer tick, asking Buildbucket for the build status
[14:29:28.527] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:28.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:52:0) after 1m0s
[14:30:28.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:52:0)
[14:30:28.682] Timer tick, asking Buildbucket for the build status
[14:30:28.858] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:53:0) after 1m0s
[14:31:28.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:53:0)
[14:31:28.949] Timer tick, asking Buildbucket for the build status
[14:31:29.329] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:29.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:54:0) after 1m0s
[14:32:29.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:54:0)
[14:32:29.420] Timer tick, asking Buildbucket for the build status
[14:32:29.679] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:29.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:55:0) after 1m0s
[14:33:29.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:55:0)
[14:33:29.658] Timer tick, asking Buildbucket for the build status
[14:33:29.956] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:29.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:56:0) after 1m0s
[14:34:30.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:56:0)
[14:34:30.123] Timer tick, asking Buildbucket for the build status
[14:34:30.341] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:30.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:57:0) after 1m0s
[14:35:30.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:57:0)
[14:35:30.463] Timer tick, asking Buildbucket for the build status
[14:35:30.768] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:30.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:58:0) after 1m0s
[14:36:30.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:58:0)
[14:36:30.910] Timer tick, asking Buildbucket for the build status
[14:36:31.307] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:31.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:59:0) after 1m0s
[14:37:31.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:59:0)
[14:37:31.517] Timer tick, asking Buildbucket for the build status
[14:37:31.767] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:31.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:60:0) after 1m0s
[14:38:31.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:60:0)
[14:38:31.856] Timer tick, asking Buildbucket for the build status
[14:38:32.042] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:32.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:61:0) after 1m0s
[14:39:32.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:61:0)
[14:39:32.118] Timer tick, asking Buildbucket for the build status
[14:39:32.782] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:32.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:62:0) after 1m0s
[14:40:32.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:62:0)
[14:40:32.804] Timer tick, asking Buildbucket for the build status
[14:40:33.385] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:33.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:63:0) after 1m0s
[14:41:33.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:63:0)
[14:41:33.437] Timer tick, asking Buildbucket for the build status
[14:41:33.647] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:33.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:64:0) after 1m0s
[14:42:33.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:64:0)
[14:42:33.809] Timer tick, asking Buildbucket for the build status
[14:42:34.546] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:34.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:65:0) after 1m0s
[14:43:34.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:65:0)
[14:43:34.576] Timer tick, asking Buildbucket for the build status
[14:43:36.006] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:36.006] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:66:0) after 1m0s
[14:44:36.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:66:0)
[14:44:36.032] Timer tick, asking Buildbucket for the build status
[14:44:36.379] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:36.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:67:0) after 1m0s
[14:45:36.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:67:0)
[14:45:36.379] Timer tick, asking Buildbucket for the build status
[14:45:36.558] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:36.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:68:0) after 1m0s
[14:46:36.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:68:0)
[14:46:36.825] Timer tick, asking Buildbucket for the build status
[14:46:37.836] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:37.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:69:0) after 1m0s
[14:47:37.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:69:0)
[14:47:37.880] Timer tick, asking Buildbucket for the build status
[14:47:38.033] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:38.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:70:0) after 1m0s
[14:48:38.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:70:0)
[14:48:38.115] Timer tick, asking Buildbucket for the build status
[14:48:38.408] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:38.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:71:0) after 1m0s
[14:49:38.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:71:0)
[14:49:38.524] Timer tick, asking Buildbucket for the build status
[14:49:38.808] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:38.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:72:0) after 1m0s
[14:50:38.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:72:0)
[14:50:38.893] Timer tick, asking Buildbucket for the build status
[14:50:39.059] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:39.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:73:0) after 1m0s
[14:51:39.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:73:0)
[14:51:39.191] Timer tick, asking Buildbucket for the build status
[14:51:39.354] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:39.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:74:0) after 1m0s
[14:52:39.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:74:0)
[14:52:39.385] Timer tick, asking Buildbucket for the build status
[14:52:39.863] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:39.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:75:0) after 1m0s
[14:53:39.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:75:0)
[14:53:39.915] Timer tick, asking Buildbucket for the build status
[14:53:40.199] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:40.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:76:0) after 1m0s
[14:54:40.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:76:0)
[14:54:40.255] Timer tick, asking Buildbucket for the build status
[14:54:40.571] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:40.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:77:0) after 1m0s
[14:55:40.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:77:0)
[14:55:40.668] Timer tick, asking Buildbucket for the build status
[14:55:41.280] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:41.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:78:0) after 1m0s
[14:56:41.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:78:0)
[14:56:41.306] Timer tick, asking Buildbucket for the build status
[14:56:41.472] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:41.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:79:0) after 1m0s
[14:57:41.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:79:0)
[14:57:41.505] Timer tick, asking Buildbucket for the build status
[14:57:41.714] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:41.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:80:0) after 1m0s
[14:58:41.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:80:0)
[14:58:41.712] Timer tick, asking Buildbucket for the build status
[14:58:41.885] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:41.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:81:0) after 1m0s
[14:59:42.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:81:0)
[14:59:42.075] Timer tick, asking Buildbucket for the build status
[14:59:42.281] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:42.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:82:0) after 1m0s
[15:00:42.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:82:0)
[15:00:42.535] Timer tick, asking Buildbucket for the build status
[15:00:42.826] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:42.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:83:0) after 1m0s
[15:01:42.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:83:0)
[15:01:42.881] Timer tick, asking Buildbucket for the build status
[15:01:43.800] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:43.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:84:0) after 1m0s
[15:02:43.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:84:0)
[15:02:43.930] Timer tick, asking Buildbucket for the build status
[15:02:44.246] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:44.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:85:0) after 1m0s
[15:03:44.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:85:0)
[15:03:44.276] Timer tick, asking Buildbucket for the build status
[15:03:44.585] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:44.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:86:0) after 1m0s
[15:04:44.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:86:0)
[15:04:44.814] Timer tick, asking Buildbucket for the build status
[15:04:45.551] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:45.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:87:0) after 1m0s
[15:05:45.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:87:0)
[15:05:45.577] Timer tick, asking Buildbucket for the build status
[15:05:46.136] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:46.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:88:0) after 1m0s
[15:06:46.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:88:0)
[15:06:46.146] Timer tick, asking Buildbucket for the build status
[15:06:46.367] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:46.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:89:0) after 1m0s
[15:07:46.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:89:0)
[15:07:46.397] Timer tick, asking Buildbucket for the build status
[15:07:46.972] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:46.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:90:0) after 1m0s
[15:08:47.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:90:0)
[15:08:47.044] Timer tick, asking Buildbucket for the build status
[15:08:47.844] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:47.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:91:0) after 1m0s
[15:09:47.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:91:0)
[15:09:47.865] Timer tick, asking Buildbucket for the build status
[15:09:48.052] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:48.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:92:0) after 1m0s
[15:10:48.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:92:0)
[15:10:48.113] Timer tick, asking Buildbucket for the build status
[15:10:48.293] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:48.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:93:0) after 1m0s
[15:11:48.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:93:0)
[15:11:48.340] Timer tick, asking Buildbucket for the build status
[15:11:48.574] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:48.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:94:0) after 1m0s
[15:12:48.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:94:0)
[15:12:48.586] Timer tick, asking Buildbucket for the build status
[15:12:49.457] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:49.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:95:0) after 1m0s
[15:13:49.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:95:0)
[15:13:49.564] Timer tick, asking Buildbucket for the build status
[15:13:49.723] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:49.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:96:0) after 1m0s
[15:14:49.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:96:0)
[15:14:49.774] Timer tick, asking Buildbucket for the build status
[15:14:49.998] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:49.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:97:0) after 1m0s
[15:15:50.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:97:0)
[15:15:50.024] Timer tick, asking Buildbucket for the build status
[15:15:50.873] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:50.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:98:0) after 1m0s
[15:16:50.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:98:0)
[15:16:50.893] Timer tick, asking Buildbucket for the build status
[15:16:51.152] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:51.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:99:0) after 1m0s
[15:17:51.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:99:0)
[15:17:51.178] Timer tick, asking Buildbucket for the build status
[15:17:51.447] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:51.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:100:0) after 1m0s
[15:18:51.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:100:0)
[15:18:51.469] Timer tick, asking Buildbucket for the build status
[15:18:51.991] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:51.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:101:0) after 1m0s
[15:19:52.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:101:0)
[15:19:52.057] Timer tick, asking Buildbucket for the build status
[15:19:52.923] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:52.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:102:0) after 1m0s
[15:20:53.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:102:0)
[15:20:53.001] Timer tick, asking Buildbucket for the build status
[15:20:53.203] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:53.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:103:0) after 1m0s
[15:21:53.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:103:0)
[15:21:53.183] Timer tick, asking Buildbucket for the build status
[15:21:53.592] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:53.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:104:0) after 1m0s
[15:22:53.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:104:0)
[15:22:53.835] Timer tick, asking Buildbucket for the build status
[15:22:54.019] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:54.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:105:0) after 1m0s
[15:23:54.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:105:0)
[15:23:54.134] Timer tick, asking Buildbucket for the build status
[15:23:54.281] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:54.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:106:0) after 1m0s
[15:24:54.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:106:0)
[15:24:54.601] Timer tick, asking Buildbucket for the build status
[15:24:54.736] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:54.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:107:0) after 1m0s
[15:25:54.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:107:0)
[15:25:54.855] Timer tick, asking Buildbucket for the build status
[15:25:55.054] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:55.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:108:0) after 1m0s
[15:26:55.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:108:0)
[15:26:55.266] Timer tick, asking Buildbucket for the build status
[15:26:55.777] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:55.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:109:0) after 1m0s
[15:27:55.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:109:0)
[15:27:55.810] Timer tick, asking Buildbucket for the build status
[15:27:56.010] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:56.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:110:0) after 1m0s
[15:28:55.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:110:0)
[15:28:55.995] Timer tick, asking Buildbucket for the build status
[15:28:56.559] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:56.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:111:0) after 1m0s
[15:29:56.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:111:0)
[15:29:56.649] Timer tick, asking Buildbucket for the build status
[15:29:57.009] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:57.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:112:0) after 1m0s
[15:30:57.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:112:0)
[15:30:57.187] Timer tick, asking Buildbucket for the build status
[15:30:57.403] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:57.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:113:0) after 1m0s
[15:31:57.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:113:0)
[15:31:57.462] Timer tick, asking Buildbucket for the build status
[15:31:57.616] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:57.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:114:0) after 1m0s
[15:32:57.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:114:0)
[15:32:57.689] Timer tick, asking Buildbucket for the build status
[15:32:58.205] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:58.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:115:0) after 1m0s
[15:33:58.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:115:0)
[15:33:58.334] Timer tick, asking Buildbucket for the build status
[15:33:58.516] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:58.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:116:0) after 1m0s
[15:34:58.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:116:0)
[15:34:58.692] Timer tick, asking Buildbucket for the build status
[15:34:58.846] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:58.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:117:0) after 1m0s
[15:35:58.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:117:0)
[15:35:58.874] Timer tick, asking Buildbucket for the build status
[15:35:59.570] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:59.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:118:0) after 1m0s
[15:36:59.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:118:0)
[15:36:59.721] Timer tick, asking Buildbucket for the build status
[15:36:59.949] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:59.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:119:0) after 1m0s
[15:38:00.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:119:0)
[15:38:00.044] Timer tick, asking Buildbucket for the build status
[15:38:00.704] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:00.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:120:0) after 1m0s
[15:39:00.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:120:0)
[15:39:00.789] Timer tick, asking Buildbucket for the build status
[15:39:00.950] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:00.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:121:0) after 1m0s
[15:40:01.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:121:0)
[15:40:01.049] Timer tick, asking Buildbucket for the build status
[15:40:01.395] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:01.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:122:0) after 1m0s
[15:41:01.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:122:0)
[15:41:01.418] Timer tick, asking Buildbucket for the build status
[15:41:01.620] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:01.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:123:0) after 1m0s
[15:42:01.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:123:0)
[15:42:01.784] Timer tick, asking Buildbucket for the build status
[15:42:02.639] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:02.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:124:0) after 1m0s
[15:43:02.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:124:0)
[15:43:02.723] Timer tick, asking Buildbucket for the build status
[15:43:03.845] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:03.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:125:0) after 1m0s
[15:44:03.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:125:0)
[15:44:03.866] Timer tick, asking Buildbucket for the build status
[15:44:04.113] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:04.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:126:0) after 1m0s
[15:45:04.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:126:0)
[15:45:04.188] Timer tick, asking Buildbucket for the build status
[15:45:04.327] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:04.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:127:0) after 1m0s
[15:46:04.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:127:0)
[15:46:04.348] Timer tick, asking Buildbucket for the build status
[15:46:04.506] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:04.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:128:0) after 1m0s
[15:47:04.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:128:0)
[15:47:04.538] Timer tick, asking Buildbucket for the build status
[15:47:04.750] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:04.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:129:0) after 1m0s
[15:48:04.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:129:0)
[15:48:04.782] Timer tick, asking Buildbucket for the build status
[15:48:05.575] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:05.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:130:0) after 1m0s
[15:49:05.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:130:0)
[15:49:05.601] Timer tick, asking Buildbucket for the build status
[15:49:05.829] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:05.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:131:0) after 1m0s
[15:50:05.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:131:0)
[15:50:05.850] Timer tick, asking Buildbucket for the build status
[15:50:06.429] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:06.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:132:0) after 1m0s
[15:51:06.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:132:0)
[15:51:06.479] Timer tick, asking Buildbucket for the build status
[15:51:06.638] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:06.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:133:0) after 1m0s
[15:52:06.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:133:0)
[15:52:06.675] Timer tick, asking Buildbucket for the build status
[15:52:06.913] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:06.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:134:0) after 1m0s
[15:53:06.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:134:0)
[15:53:06.943] Timer tick, asking Buildbucket for the build status
[15:53:07.155] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:07.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:135:0) after 1m0s
[15:54:07.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:135:0)
[15:54:07.180] Timer tick, asking Buildbucket for the build status
[15:54:07.335] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:07.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:136:0) after 1m0s
[15:55:07.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:136:0)
[15:55:07.333] Timer tick, asking Buildbucket for the build status
[15:55:08.206] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:08.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:137:0) after 1m0s
[15:56:08.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:137:0)
[15:56:08.231] Timer tick, asking Buildbucket for the build status
[15:56:08.472] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:08.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:138:0) after 1m0s
[15:57:08.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:138:0)
[15:57:08.496] Timer tick, asking Buildbucket for the build status
[15:57:09.275] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:09.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:139:0) after 1m0s
[15:58:09.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:139:0)
[15:58:09.307] Timer tick, asking Buildbucket for the build status
[15:58:09.499] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:09.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:140:0) after 1m0s
[15:59:09.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:140:0)
[15:59:09.635] Timer tick, asking Buildbucket for the build status
[15:59:09.812] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:09.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:141:0) after 1m0s
[16:00:09.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:141:0)
[16:00:09.875] Timer tick, asking Buildbucket for the build status
[16:00:10.086] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:10.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:142:0) after 1m0s
[16:01:10.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:142:0)
[16:01:10.310] Timer tick, asking Buildbucket for the build status
[16:01:10.491] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:10.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:143:0) after 1m0s
[16:02:10.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:143:0)
[16:02:10.672] Timer tick, asking Buildbucket for the build status
[16:02:10.857] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:10.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:144:0) after 1m0s
[16:03:10.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:144:0)
[16:03:10.898] Timer tick, asking Buildbucket for the build status
[16:03:11.054] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:11.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:145:0) after 1m0s
[16:04:11.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:145:0)
[16:04:11.077] Timer tick, asking Buildbucket for the build status
[16:04:11.565] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:11.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:146:0) after 1m0s
[16:05:11.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:146:0)
[16:05:11.629] Timer tick, asking Buildbucket for the build status
[16:05:11.988] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:11.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:147:0) after 1m0s
[16:06:12.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:147:0)
[16:06:12.179] Timer tick, asking Buildbucket for the build status
[16:06:12.476] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:12.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:148:0) after 1m0s
[16:07:12.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:148:0)
[16:07:12.499] Timer tick, asking Buildbucket for the build status
[16:07:13.035] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:13.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:149:0) after 1m0s
[16:08:13.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:149:0)
[16:08:13.210] Timer tick, asking Buildbucket for the build status
[16:08:13.417] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:13.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:150:0) after 1m0s
[16:09:13.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:150:0)
[16:09:13.497] Timer tick, asking Buildbucket for the build status
[16:09:13.651] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:13.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:151:0) after 1m0s
[16:10:13.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:151:0)
[16:10:13.666] Timer tick, asking Buildbucket for the build status
[16:10:14.173] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:14.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:152:0) after 1m0s
[16:11:14.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:152:0)
[16:11:14.442] Timer tick, asking Buildbucket for the build status
[16:11:14.617] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:14.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:153:0) after 1m0s
[16:12:14.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:153:0)
[16:12:14.799] Timer tick, asking Buildbucket for the build status
[16:12:15.078] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:15.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:154:0) after 1m0s
[16:13:15.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:154:0)
[16:13:15.155] Timer tick, asking Buildbucket for the build status
[16:13:16.101] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:16.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:155:0) after 1m0s
[16:14:16.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:155:0)
[16:14:16.199] Timer tick, asking Buildbucket for the build status
[16:14:16.465] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:16.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:156:0) after 1m0s
[16:15:16.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:156:0)
[16:15:16.642] Timer tick, asking Buildbucket for the build status
[16:15:16.780] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:16.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:157:0) after 1m0s
[16:16:16.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:157:0)
[16:16:16.807] Timer tick, asking Buildbucket for the build status
[16:16:16.971] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:16.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:158:0) after 1m0s
[16:17:16.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:158:0)
[16:17:16.993] Timer tick, asking Buildbucket for the build status
[16:17:17.171] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:17.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:159:0) after 1m0s
[16:18:17.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:159:0)
[16:18:17.208] Timer tick, asking Buildbucket for the build status
[16:18:17.434] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:17.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:160:0) after 1m0s
[16:19:17.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:160:0)
[16:19:17.471] Timer tick, asking Buildbucket for the build status
[16:19:17.575] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:17.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:161:0) after 1m0s
[16:20:17.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:161:0)
[16:20:17.556] Timer tick, asking Buildbucket for the build status
[16:20:17.747] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:162:0) after 1m0s
[16:21:17.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:162:0)
[16:21:17.773] Timer tick, asking Buildbucket for the build status
[16:21:18.136] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:18.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:163:0) after 1m0s
[16:22:18.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:163:0)
[16:22:18.173] Timer tick, asking Buildbucket for the build status
[16:22:18.447] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:18.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:164:0) after 1m0s
[16:23:18.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:164:0)
[16:23:18.532] Timer tick, asking Buildbucket for the build status
[16:23:19.065] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:19.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:165:0) after 1m0s
[16:24:19.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:165:0)
[16:24:19.118] Timer tick, asking Buildbucket for the build status
[16:24:19.438] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:19.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:166:0) after 1m0s
[16:25:19.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:166:0)
[16:25:19.488] Timer tick, asking Buildbucket for the build status
[16:25:19.937] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:19.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:167:0) after 1m0s
[16:26:19.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:167:0)
[16:26:19.962] Timer tick, asking Buildbucket for the build status
[16:26:20.239] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:20.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:168:0) after 1m0s
[16:27:20.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:168:0)
[16:27:20.249] Timer tick, asking Buildbucket for the build status
[16:27:20.408] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:20.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:169:0) after 1m0s
[16:28:20.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:169:0)
[16:28:20.621] Timer tick, asking Buildbucket for the build status
[16:28:21.257] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:21.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:170:0) after 1m0s
[16:29:21.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:170:0)
[16:29:21.284] Timer tick, asking Buildbucket for the build status
[16:29:21.581] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:21.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:171:0) after 1m0s
[16:30:21.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:171:0)
[16:30:21.623] Timer tick, asking Buildbucket for the build status
[16:30:22.696] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:22.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:172:0) after 1m0s
[16:31:22.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:172:0)
[16:31:22.726] Timer tick, asking Buildbucket for the build status
[16:31:22.965] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:22.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:173:0) after 1m0s
[16:32:23.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:173:0)
[16:32:23.102] Timer tick, asking Buildbucket for the build status
[16:32:23.416] Build 8893185095158728912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:23.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058615157217372832:174:0) after 1m0s
[16:32:30.504] Received PubSub notification, asking Buildbucket for the build status
[16:32:30.819] Build 8893185095158728912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:32:30.819] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577205149464732",
"created_by": "project:chromium",
"created_ts": "1577194805908310",
"id": "8893185095158728912",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a1848663f783c60fe19ccbd8808d1ae539473797\"}}",
"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-6o2q\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15531, \"got_angle_revision\": \"87607526c693581b20de9e75c42594b1fb4943ec\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"a1848663f783c60fe19ccbd8808d1ae539473797\", \"got_revision_cp\": \"refs/heads/master@{#727373}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6e3a387c01598240a7a8722ab8cbd1015ec1cd0a\", \"got_v8_revision\": \"dfd29b84bf55ce66c063bf472974fcd7ac793a17\", \"got_v8_revision_cp\": \"refs/heads/8.1.74@{#1}\", \"got_webrtc_revision\": \"26762d0425ffd15af9ddc3ae669373668827ea00\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30125}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a1848663f783c60fe19ccbd8808d1ae539473797\"}, \"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-6o2q\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4733-6bd8c41\"], \"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": "1577194816551531",
"status": "COMPLETED",
"status_changed_ts": "1577205149966964",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15531",
"builder:Windows deterministic",
"buildset:commit/git/a1848663f783c60fe19ccbd8808d1ae539473797",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1848663f783c60fe19ccbd8808d1ae539473797",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058615157217372832",
"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/8893185095158728912/+/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:4950f47f4a2ce310",
"user_agent:luci-scheduler"
],
"updated_ts": "1577205149979680",
"url": "https://ci.chromium.org/b/8893185095158728912",
"utcnow_ts": "1577205150797450"
}
}
[16:32:30.819] Invocation finished in 2h52m26.25780727s with status SUCCEEDED