[05:56:12.937] New invocation is queued and will start shortly
[05:56:14.377] Starting the invocation (attempt 1)
[05:56:14.488] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:56:14.488] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:56:14.488] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062268219466744896",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"890d67c050dca0b2484f028012f1bf817af78d5a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9062268219466744896",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/890d67c050dca0b2484f028012f1bf817af78d5a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890d67c050dca0b2484f028012f1bf817af78d5a",
"gitiles_ref:refs/heads/master"
]
}
[05:56:16.640] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573710975914293",
"id": "8896838155677813456",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890d67c050dca0b2484f028012f1bf817af78d5a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573710976446582",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15197",
"builder:Windows deterministic",
"buildset:commit/git/890d67c050dca0b2484f028012f1bf817af78d5a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890d67c050dca0b2484f028012f1bf817af78d5a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062268219466744896",
"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/8896838155677813456/+/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": "1573710976446706",
"url": "https://ci.chromium.org/b/8896838155677813456",
"utcnow_ts": "1573710976611040"
}
}
[05:56:16.640] Task URL: https://ci.chromium.org/b/8896838155677813456
[05:56:16.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:2:0) after 1m0s
[05:57:16.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:2:0)
[05:57:16.708] Timer tick, asking Buildbucket for the build status
[05:57:16.917] Build 8896838155677813456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:16.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:3:0) after 1m0s
[05:58:17.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:3:0)
[05:58:17.102] Timer tick, asking Buildbucket for the build status
[05:58:18.005] Build 8896838155677813456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:18.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:4:0) after 1m0s
[05:58:43.641] Received PubSub notification, asking Buildbucket for the build status
[05:58:43.874] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:18.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:4:0)
[05:59:18.010] Timer tick, asking Buildbucket for the build status
[05:59:19.272] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:6:0) after 1m0s
[06:00:19.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:6:0)
[06:00:19.380] Timer tick, asking Buildbucket for the build status
[06:00:20.400] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:20.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:7:0) after 1m0s
[06:01:20.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:7:0)
[06:01:20.431] Timer tick, asking Buildbucket for the build status
[06:01:22.901] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:22.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:8:0) after 1m0s
[06:02:22.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:8:0)
[06:02:22.924] Timer tick, asking Buildbucket for the build status
[06:02:23.206] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:23.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:9:0) after 1m0s
[06:03:23.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:9:0)
[06:03:23.265] Timer tick, asking Buildbucket for the build status
[06:03:23.868] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:23.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:10:0) after 1m0s
[06:04:24.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:10:0)
[06:04:24.015] Timer tick, asking Buildbucket for the build status
[06:04:24.901] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:24.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:11:0) after 1m0s
[06:05:25.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:11:0)
[06:05:25.013] Timer tick, asking Buildbucket for the build status
[06:05:26.003] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:26.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:12:0) after 1m0s
[06:06:26.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:12:0)
[06:06:26.058] Timer tick, asking Buildbucket for the build status
[06:06:26.318] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:26.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:13:0) after 1m0s
[06:07:26.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:13:0)
[06:07:26.352] Timer tick, asking Buildbucket for the build status
[06:07:27.160] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:27.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:14:0) after 1m0s
[06:08:27.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:14:0)
[06:08:27.211] Timer tick, asking Buildbucket for the build status
[06:08:29.386] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:29.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:15:0) after 1m0s
[06:09:29.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:15:0)
[06:09:29.462] Timer tick, asking Buildbucket for the build status
[06:09:29.727] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:16:0) after 1m0s
[06:10:29.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:16:0)
[06:10:29.754] Timer tick, asking Buildbucket for the build status
[06:10:30.320] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:30.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:17:0) after 1m0s
[06:11:30.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:17:0)
[06:11:30.662] Timer tick, asking Buildbucket for the build status
[06:11:30.934] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:30.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:18:0) after 1m0s
[06:12:31.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:18:0)
[06:12:31.194] Timer tick, asking Buildbucket for the build status
[06:12:32.297] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:32.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:19:0) after 1m0s
[06:13:32.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:19:0)
[06:13:32.374] Timer tick, asking Buildbucket for the build status
[06:13:33.043] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:33.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:20:0) after 1m0s
[06:14:33.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:20:0)
[06:14:33.125] Timer tick, asking Buildbucket for the build status
[06:14:33.832] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:33.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:21:0) after 1m0s
[06:15:33.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:21:0)
[06:15:33.968] Timer tick, asking Buildbucket for the build status
[06:15:34.778] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:34.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:22:0) after 1m0s
[06:16:34.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:22:0)
[06:16:34.854] Timer tick, asking Buildbucket for the build status
[06:16:35.779] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:35.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:23:0) after 1m0s
[06:17:35.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:23:0)
[06:17:35.810] Timer tick, asking Buildbucket for the build status
[06:17:38.254] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:38.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:24:0) after 1m0s
[06:18:38.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:24:0)
[06:18:38.354] Timer tick, asking Buildbucket for the build status
[06:18:38.574] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:38.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:25:0) after 1m0s
[06:19:38.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:25:0)
[06:19:38.650] Timer tick, asking Buildbucket for the build status
[06:19:39.027] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:39.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:26:0) after 1m0s
[06:20:39.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:26:0)
[06:20:39.066] Timer tick, asking Buildbucket for the build status
[06:20:41.712] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:41.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:27:0) after 1m0s
[06:21:41.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:27:0)
[06:21:41.760] Timer tick, asking Buildbucket for the build status
[06:21:42.022] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:42.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:28:0) after 1m0s
[06:22:42.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:28:0)
[06:22:42.048] Timer tick, asking Buildbucket for the build status
[06:22:43.046] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:43.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:29:0) after 1m0s
[06:23:43.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:29:0)
[06:23:43.095] Timer tick, asking Buildbucket for the build status
[06:23:43.771] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:43.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:30:0) after 1m0s
[06:24:43.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:30:0)
[06:24:43.840] Timer tick, asking Buildbucket for the build status
[06:24:44.075] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:44.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:31:0) after 1m0s
[06:25:44.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:31:0)
[06:25:44.426] Timer tick, asking Buildbucket for the build status
[06:25:51.015] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:51.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:32:0) after 1m0s
[06:26:51.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:32:0)
[06:26:51.047] Timer tick, asking Buildbucket for the build status
[06:26:51.467] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:51.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:33:0) after 1m0s
[06:27:51.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:33:0)
[06:27:51.561] Timer tick, asking Buildbucket for the build status
[06:27:54.460] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:54.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:34:0) after 1m0s
[06:28:54.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:34:0)
[06:28:54.562] Timer tick, asking Buildbucket for the build status
[06:28:55.940] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:55.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:35:0) after 1m0s
[06:29:56.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:35:0)
[06:29:56.039] Timer tick, asking Buildbucket for the build status
[06:29:56.280] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:56.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:36:0) after 1m0s
[06:30:56.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:36:0)
[06:30:56.355] Timer tick, asking Buildbucket for the build status
[06:30:56.609] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:56.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:37:0) after 1m0s
[06:31:56.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:37:0)
[06:31:56.639] Timer tick, asking Buildbucket for the build status
[06:31:57.443] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:57.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:38:0) after 1m0s
[06:32:57.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:38:0)
[06:32:57.487] Timer tick, asking Buildbucket for the build status
[06:32:57.990] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:57.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:39:0) after 1m0s
[06:33:58.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:39:0)
[06:33:58.069] Timer tick, asking Buildbucket for the build status
[06:33:58.570] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:58.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:40:0) after 1m0s
[06:34:58.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:40:0)
[06:34:58.604] Timer tick, asking Buildbucket for the build status
[06:34:59.464] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:59.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:41:0) after 1m0s
[06:35:59.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:41:0)
[06:35:59.477] Timer tick, asking Buildbucket for the build status
[06:35:59.750] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:59.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:42:0) after 1m0s
[06:36:59.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:42:0)
[06:36:59.801] Timer tick, asking Buildbucket for the build status
[06:37:00.210] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:00.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:43:0) after 1m0s
[06:38:00.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:43:0)
[06:38:00.259] Timer tick, asking Buildbucket for the build status
[06:38:00.819] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:00.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:44:0) after 1m0s
[06:39:00.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:44:0)
[06:39:00.863] Timer tick, asking Buildbucket for the build status
[06:39:01.321] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:01.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:45:0) after 1m0s
[06:40:01.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:45:0)
[06:40:01.349] Timer tick, asking Buildbucket for the build status
[06:40:01.739] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:01.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:46:0) after 1m0s
[06:41:01.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:46:0)
[06:41:01.766] Timer tick, asking Buildbucket for the build status
[06:41:02.525] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:02.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:47:0) after 1m0s
[06:42:02.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:47:0)
[06:42:02.602] Timer tick, asking Buildbucket for the build status
[06:42:03.320] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:03.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:48:0) after 1m0s
[06:43:03.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:48:0)
[06:43:03.472] Timer tick, asking Buildbucket for the build status
[06:43:04.614] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:04.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:49:0) after 1m0s
[06:44:04.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:49:0)
[06:44:04.668] Timer tick, asking Buildbucket for the build status
[06:44:05.927] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:05.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:50:0) after 1m0s
[06:45:06.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:50:0)
[06:45:06.056] Timer tick, asking Buildbucket for the build status
[06:45:06.647] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:06.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:51:0) after 1m0s
[06:46:06.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:51:0)
[06:46:06.792] Timer tick, asking Buildbucket for the build status
[06:46:06.982] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:06.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:52:0) after 1m0s
[06:47:07.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:52:0)
[06:47:07.019] Timer tick, asking Buildbucket for the build status
[06:47:07.757] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:07.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:53:0) after 1m0s
[06:48:07.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:53:0)
[06:48:07.825] Timer tick, asking Buildbucket for the build status
[06:48:10.363] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:10.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:54:0) after 1m0s
[06:49:10.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:54:0)
[06:49:10.451] Timer tick, asking Buildbucket for the build status
[06:49:10.672] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:10.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:55:0) after 1m0s
[06:50:10.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:55:0)
[06:50:10.731] Timer tick, asking Buildbucket for the build status
[06:50:13.098] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:13.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:56:0) after 1m0s
[06:51:13.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:56:0)
[06:51:13.232] Timer tick, asking Buildbucket for the build status
[06:51:13.654] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:13.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:57:0) after 1m0s
[06:52:14.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:57:0)
[06:52:14.000] Timer tick, asking Buildbucket for the build status
[06:52:14.228] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:14.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:58:0) after 1m0s
[06:53:14.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:58:0)
[06:53:14.941] Timer tick, asking Buildbucket for the build status
[06:53:15.812] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:15.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:59:0) after 1m0s
[06:54:15.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:59:0)
[06:54:15.983] Timer tick, asking Buildbucket for the build status
[06:54:16.207] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:16.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:60:0) after 1m0s
[06:55:16.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:60:0)
[06:55:16.250] Timer tick, asking Buildbucket for the build status
[06:55:16.561] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:16.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:61:0) after 1m0s
[06:56:17.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:61:0)
[06:56:17.065] Timer tick, asking Buildbucket for the build status
[06:56:17.681] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:17.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:62:0) after 1m0s
[06:57:17.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:62:0)
[06:57:17.852] Timer tick, asking Buildbucket for the build status
[06:57:18.473] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:18.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:63:0) after 1m0s
[06:58:18.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:63:0)
[06:58:18.839] Timer tick, asking Buildbucket for the build status
[06:58:19.256] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:19.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:64:0) after 1m0s
[06:59:19.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:64:0)
[06:59:19.310] Timer tick, asking Buildbucket for the build status
[06:59:20.544] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:20.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:65:0) after 1m0s
[07:00:20.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:65:0)
[07:00:20.596] Timer tick, asking Buildbucket for the build status
[07:00:20.885] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:20.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:66:0) after 1m0s
[07:01:20.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:66:0)
[07:01:20.911] Timer tick, asking Buildbucket for the build status
[07:01:21.333] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:21.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:67:0) after 1m0s
[07:02:21.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:67:0)
[07:02:21.466] Timer tick, asking Buildbucket for the build status
[07:02:22.023] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:22.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:68:0) after 1m0s
[07:03:22.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:68:0)
[07:03:22.194] Timer tick, asking Buildbucket for the build status
[07:03:22.894] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:22.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:69:0) after 1m0s
[07:04:23.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:69:0)
[07:04:23.084] Timer tick, asking Buildbucket for the build status
[07:04:23.955] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:23.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:70:0) after 1m0s
[07:05:24.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:70:0)
[07:05:24.030] Timer tick, asking Buildbucket for the build status
[07:05:24.429] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:24.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:71:0) after 1m0s
[07:06:24.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:71:0)
[07:06:24.579] Timer tick, asking Buildbucket for the build status
[07:06:25.101] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:25.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:72:0) after 1m0s
[07:07:25.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:72:0)
[07:07:25.113] Timer tick, asking Buildbucket for the build status
[07:07:25.512] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:25.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:73:0) after 1m0s
[07:08:25.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:73:0)
[07:08:25.639] Timer tick, asking Buildbucket for the build status
[07:08:25.889] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:25.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:74:0) after 1m0s
[07:09:26.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:74:0)
[07:09:26.026] Timer tick, asking Buildbucket for the build status
[07:09:28.233] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:28.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:75:0) after 1m0s
[07:10:28.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:75:0)
[07:10:28.283] Timer tick, asking Buildbucket for the build status
[07:10:28.812] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:28.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:76:0) after 1m0s
[07:11:28.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:76:0)
[07:11:28.929] Timer tick, asking Buildbucket for the build status
[07:11:29.295] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:29.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:77:0) after 1m0s
[07:12:29.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:77:0)
[07:12:29.319] Timer tick, asking Buildbucket for the build status
[07:12:30.241] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:30.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:78:0) after 1m0s
[07:13:30.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:78:0)
[07:13:30.283] Timer tick, asking Buildbucket for the build status
[07:13:31.753] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:31.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:79:0) after 1m0s
[07:14:31.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:79:0)
[07:14:31.846] Timer tick, asking Buildbucket for the build status
[07:14:32.301] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:32.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:80:0) after 1m0s
[07:15:32.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:80:0)
[07:15:32.340] Timer tick, asking Buildbucket for the build status
[07:15:32.572] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:32.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:81:0) after 1m0s
[07:16:32.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:81:0)
[07:16:32.789] Timer tick, asking Buildbucket for the build status
[07:16:33.353] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:33.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:82:0) after 1m0s
[07:17:33.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:82:0)
[07:17:33.615] Timer tick, asking Buildbucket for the build status
[07:17:33.936] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:33.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:83:0) after 1m0s
[07:18:33.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:83:0)
[07:18:33.952] Timer tick, asking Buildbucket for the build status
[07:18:34.206] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:34.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:84:0) after 1m0s
[07:19:34.291] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:84:0)
[07:19:34.291] Timer tick, asking Buildbucket for the build status
[07:19:34.568] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:34.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:85:0) after 1m0s
[07:20:34.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:85:0)
[07:20:34.665] Timer tick, asking Buildbucket for the build status
[07:20:35.320] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:35.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:86:0) after 1m0s
[07:21:35.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:86:0)
[07:21:35.453] Timer tick, asking Buildbucket for the build status
[07:21:37.680] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:37.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:87:0) after 1m0s
[07:22:37.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:87:0)
[07:22:37.726] Timer tick, asking Buildbucket for the build status
[07:22:37.962] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:37.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:88:0) after 1m0s
[07:23:38.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:88:0)
[07:23:38.081] Timer tick, asking Buildbucket for the build status
[07:23:38.362] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:38.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:89:0) after 1m0s
[07:24:38.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:89:0)
[07:24:38.447] Timer tick, asking Buildbucket for the build status
[07:24:39.360] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:39.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:90:0) after 1m0s
[07:25:39.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:90:0)
[07:25:39.463] Timer tick, asking Buildbucket for the build status
[07:25:40.525] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:40.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:91:0) after 1m0s
[07:26:40.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:91:0)
[07:26:40.647] Timer tick, asking Buildbucket for the build status
[07:26:40.765] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:40.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:92:0) after 1m0s
[07:27:40.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:92:0)
[07:27:40.797] Timer tick, asking Buildbucket for the build status
[07:27:42.311] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:42.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:93:0) after 1m0s
[07:28:42.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:93:0)
[07:28:42.344] Timer tick, asking Buildbucket for the build status
[07:28:42.516] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:42.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:94:0) after 1m0s
[07:29:42.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:94:0)
[07:29:42.601] Timer tick, asking Buildbucket for the build status
[07:29:45.675] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:45.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:95:0) after 1m0s
[07:30:45.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:95:0)
[07:30:45.743] Timer tick, asking Buildbucket for the build status
[07:30:46.036] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:46.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:96:0) after 1m0s
[07:31:46.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:96:0)
[07:31:46.104] Timer tick, asking Buildbucket for the build status
[07:31:46.552] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:46.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:97:0) after 1m0s
[07:32:46.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:97:0)
[07:32:46.727] Timer tick, asking Buildbucket for the build status
[07:32:47.033] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:47.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:98:0) after 1m0s
[07:33:47.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:98:0)
[07:33:47.193] Timer tick, asking Buildbucket for the build status
[07:33:47.542] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:47.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:99:0) after 1m0s
[07:34:47.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:99:0)
[07:34:47.611] Timer tick, asking Buildbucket for the build status
[07:34:48.065] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:48.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:100:0) after 1m0s
[07:35:48.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:100:0)
[07:35:48.239] Timer tick, asking Buildbucket for the build status
[07:35:49.341] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:49.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:101:0) after 1m0s
[07:36:49.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:101:0)
[07:36:49.590] Timer tick, asking Buildbucket for the build status
[07:36:50.099] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:50.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:102:0) after 1m0s
[07:37:50.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:102:0)
[07:37:50.343] Timer tick, asking Buildbucket for the build status
[07:37:51.499] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:51.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:103:0) after 1m0s
[07:38:51.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:103:0)
[07:38:51.606] Timer tick, asking Buildbucket for the build status
[07:38:51.797] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:51.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:104:0) after 1m0s
[07:39:51.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:104:0)
[07:39:51.968] Timer tick, asking Buildbucket for the build status
[07:39:52.213] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:52.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:105:0) after 1m0s
[07:40:52.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:105:0)
[07:40:52.403] Timer tick, asking Buildbucket for the build status
[07:40:52.635] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:52.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:106:0) after 1m0s
[07:41:52.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:106:0)
[07:41:52.989] Timer tick, asking Buildbucket for the build status
[07:41:53.310] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:53.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:107:0) after 1m0s
[07:42:53.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:107:0)
[07:42:53.404] Timer tick, asking Buildbucket for the build status
[07:42:53.589] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:53.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:108:0) after 1m0s
[07:43:53.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:108:0)
[07:43:53.684] Timer tick, asking Buildbucket for the build status
[07:43:53.906] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:53.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:109:0) after 1m0s
[07:44:53.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:109:0)
[07:44:53.935] Timer tick, asking Buildbucket for the build status
[07:44:54.659] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:54.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:110:0) after 1m0s
[07:45:54.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:110:0)
[07:45:54.696] Timer tick, asking Buildbucket for the build status
[07:45:54.934] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:54.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:111:0) after 1m0s
[07:46:55.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:111:0)
[07:46:55.254] Timer tick, asking Buildbucket for the build status
[07:46:55.723] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:55.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:112:0) after 1m0s
[07:47:56.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:112:0)
[07:47:56.167] Timer tick, asking Buildbucket for the build status
[07:47:56.967] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:56.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:113:0) after 1m0s
[07:48:56.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:113:0)
[07:48:56.996] Timer tick, asking Buildbucket for the build status
[07:48:57.880] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:57.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:114:0) after 1m0s
[07:49:58.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:114:0)
[07:49:58.097] Timer tick, asking Buildbucket for the build status
[07:49:59.658] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:59.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:115:0) after 1m0s
[07:50:59.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:115:0)
[07:50:59.701] Timer tick, asking Buildbucket for the build status
[07:51:00.134] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:00.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:116:0) after 1m0s
[07:52:00.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:116:0)
[07:52:00.243] Timer tick, asking Buildbucket for the build status
[07:52:00.640] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:117:0) after 1m0s
[07:53:00.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:117:0)
[07:53:00.929] Timer tick, asking Buildbucket for the build status
[07:53:01.309] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:01.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:118:0) after 1m0s
[07:54:01.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:118:0)
[07:54:01.518] Timer tick, asking Buildbucket for the build status
[07:54:01.755] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:01.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:119:0) after 1m0s
[07:55:01.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:119:0)
[07:55:01.976] Timer tick, asking Buildbucket for the build status
[07:55:02.260] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:02.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:120:0) after 1m0s
[07:56:02.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:120:0)
[07:56:02.436] Timer tick, asking Buildbucket for the build status
[07:56:03.522] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:03.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:121:0) after 1m0s
[07:57:03.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:121:0)
[07:57:03.783] Timer tick, asking Buildbucket for the build status
[07:57:03.966] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:03.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:122:0) after 1m0s
[07:58:04.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:122:0)
[07:58:04.247] Timer tick, asking Buildbucket for the build status
[07:58:04.454] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:04.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:123:0) after 1m0s
[07:59:04.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:123:0)
[07:59:04.539] Timer tick, asking Buildbucket for the build status
[07:59:05.077] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:05.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:124:0) after 1m0s
[08:00:05.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:124:0)
[08:00:05.369] Timer tick, asking Buildbucket for the build status
[08:00:06.464] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:06.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:125:0) after 1m0s
[08:01:06.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:125:0)
[08:01:06.558] Timer tick, asking Buildbucket for the build status
[08:01:07.520] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:07.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:126:0) after 1m0s
[08:02:07.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:126:0)
[08:02:07.618] Timer tick, asking Buildbucket for the build status
[08:02:07.770] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:07.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:127:0) after 1m0s
[08:03:07.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:127:0)
[08:03:07.971] Timer tick, asking Buildbucket for the build status
[08:03:08.423] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:08.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:128:0) after 1m0s
[08:04:08.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:128:0)
[08:04:08.513] Timer tick, asking Buildbucket for the build status
[08:04:11.292] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:11.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:129:0) after 1m0s
[08:05:11.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:129:0)
[08:05:11.328] Timer tick, asking Buildbucket for the build status
[08:05:11.506] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:11.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:130:0) after 1m0s
[08:06:11.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:130:0)
[08:06:11.694] Timer tick, asking Buildbucket for the build status
[08:06:13.318] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:13.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:131:0) after 1m0s
[08:07:13.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:131:0)
[08:07:13.510] Timer tick, asking Buildbucket for the build status
[08:07:13.819] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:13.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:132:0) after 1m0s
[08:08:13.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:132:0)
[08:08:13.891] Timer tick, asking Buildbucket for the build status
[08:08:15.472] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:15.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:133:0) after 1m0s
[08:09:15.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:133:0)
[08:09:15.655] Timer tick, asking Buildbucket for the build status
[08:09:20.591] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:20.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:134:0) after 1m0s
[08:10:20.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:134:0)
[08:10:20.751] Timer tick, asking Buildbucket for the build status
[08:10:21.680] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:21.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:135:0) after 1m0s
[08:11:21.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:135:0)
[08:11:21.703] Timer tick, asking Buildbucket for the build status
[08:11:22.311] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:22.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:136:0) after 1m0s
[08:12:22.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:136:0)
[08:12:22.430] Timer tick, asking Buildbucket for the build status
[08:12:22.989] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:22.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:137:0) after 1m0s
[08:13:23.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:137:0)
[08:13:23.132] Timer tick, asking Buildbucket for the build status
[08:13:24.474] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:24.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:138:0) after 1m0s
[08:14:24.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:138:0)
[08:14:24.667] Timer tick, asking Buildbucket for the build status
[08:14:25.316] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:25.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:139:0) after 1m0s
[08:15:25.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:139:0)
[08:15:25.462] Timer tick, asking Buildbucket for the build status
[08:15:25.640] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:25.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:140:0) after 1m0s
[08:16:25.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:140:0)
[08:16:25.636] Timer tick, asking Buildbucket for the build status
[08:16:26.547] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:26.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:141:0) after 1m0s
[08:17:26.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:141:0)
[08:17:26.700] Timer tick, asking Buildbucket for the build status
[08:17:27.038] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:27.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:142:0) after 1m0s
[08:18:27.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:142:0)
[08:18:27.117] Timer tick, asking Buildbucket for the build status
[08:18:27.432] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:27.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:143:0) after 1m0s
[08:19:27.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:143:0)
[08:19:27.453] Timer tick, asking Buildbucket for the build status
[08:19:27.793] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:27.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:144:0) after 1m0s
[08:20:27.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:144:0)
[08:20:27.914] Timer tick, asking Buildbucket for the build status
[08:20:28.217] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:28.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:145:0) after 1m0s
[08:21:28.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:145:0)
[08:21:28.451] Timer tick, asking Buildbucket for the build status
[08:21:29.367] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:29.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:146:0) after 1m0s
[08:22:29.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:146:0)
[08:22:29.634] Timer tick, asking Buildbucket for the build status
[08:22:29.850] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:29.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:147:0) after 1m0s
[08:23:30.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:147:0)
[08:23:30.197] Timer tick, asking Buildbucket for the build status
[08:23:30.430] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:30.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:148:0) after 1m0s
[08:24:30.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:148:0)
[08:24:30.613] Timer tick, asking Buildbucket for the build status
[08:24:31.037] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:31.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:149:0) after 1m0s
[08:25:31.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:149:0)
[08:25:31.163] Timer tick, asking Buildbucket for the build status
[08:25:31.529] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:150:0) after 1m0s
[08:26:31.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:150:0)
[08:26:31.585] Timer tick, asking Buildbucket for the build status
[08:26:32.556] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:32.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:151:0) after 1m0s
[08:27:32.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:151:0)
[08:27:32.653] Timer tick, asking Buildbucket for the build status
[08:27:32.885] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:32.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:152:0) after 1m0s
[08:28:32.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:152:0)
[08:28:32.931] Timer tick, asking Buildbucket for the build status
[08:28:33.271] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:33.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:153:0) after 1m0s
[08:29:33.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:153:0)
[08:29:33.321] Timer tick, asking Buildbucket for the build status
[08:29:34.402] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:34.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:154:0) after 1m0s
[08:30:34.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:154:0)
[08:30:34.486] Timer tick, asking Buildbucket for the build status
[08:30:34.872] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:34.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:155:0) after 1m0s
[08:31:34.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:155:0)
[08:31:34.910] Timer tick, asking Buildbucket for the build status
[08:31:35.714] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:35.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:156:0) after 1m0s
[08:32:35.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:156:0)
[08:32:35.796] Timer tick, asking Buildbucket for the build status
[08:32:36.248] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:36.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:157:0) after 1m0s
[08:33:36.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:157:0)
[08:33:36.383] Timer tick, asking Buildbucket for the build status
[08:33:36.926] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:36.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:158:0) after 1m0s
[08:34:37.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:158:0)
[08:34:37.089] Timer tick, asking Buildbucket for the build status
[08:34:37.370] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:37.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:159:0) after 1m0s
[08:35:37.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:159:0)
[08:35:37.400] Timer tick, asking Buildbucket for the build status
[08:35:37.956] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:37.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:160:0) after 1m0s
[08:36:38.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:160:0)
[08:36:38.066] Timer tick, asking Buildbucket for the build status
[08:36:38.339] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:38.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:161:0) after 1m0s
[08:37:38.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:161:0)
[08:37:38.452] Timer tick, asking Buildbucket for the build status
[08:37:39.401] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:39.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:162:0) after 1m0s
[08:38:39.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:162:0)
[08:38:39.436] Timer tick, asking Buildbucket for the build status
[08:38:41.965] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:41.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:163:0) after 1m0s
[08:39:42.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:163:0)
[08:39:42.011] Timer tick, asking Buildbucket for the build status
[08:39:42.186] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:42.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:164:0) after 1m0s
[08:40:42.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:164:0)
[08:40:42.228] Timer tick, asking Buildbucket for the build status
[08:40:42.661] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:42.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:165:0) after 1m0s
[08:41:42.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:165:0)
[08:41:42.781] Timer tick, asking Buildbucket for the build status
[08:41:43.013] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:43.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:166:0) after 1m0s
[08:42:43.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:166:0)
[08:42:43.086] Timer tick, asking Buildbucket for the build status
[08:42:43.320] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:43.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:167:0) after 1m0s
[08:43:43.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:167:0)
[08:43:43.387] Timer tick, asking Buildbucket for the build status
[08:43:43.953] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:43.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:168:0) after 1m0s
[08:44:43.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:168:0)
[08:44:43.976] Timer tick, asking Buildbucket for the build status
[08:44:44.266] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:44.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:169:0) after 1m0s
[08:45:44.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:169:0)
[08:45:44.369] Timer tick, asking Buildbucket for the build status
[08:45:44.545] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:44.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:170:0) after 1m0s
[08:46:44.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:170:0)
[08:46:44.608] Timer tick, asking Buildbucket for the build status
[08:46:47.529] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:47.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:171:0) after 1m0s
[08:47:47.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:171:0)
[08:47:47.565] Timer tick, asking Buildbucket for the build status
[08:47:47.873] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:47.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:172:0) after 1m0s
[08:48:47.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:172:0)
[08:48:47.941] Timer tick, asking Buildbucket for the build status
[08:48:48.248] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:48.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:173:0) after 1m0s
[08:49:48.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:173:0)
[08:49:48.261] Timer tick, asking Buildbucket for the build status
[08:49:48.568] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:48.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:174:0) after 1m0s
[08:50:48.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:174:0)
[08:50:48.576] Timer tick, asking Buildbucket for the build status
[08:50:49.309] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:49.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:175:0) after 1m0s
[08:51:49.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:175:0)
[08:51:49.348] Timer tick, asking Buildbucket for the build status
[08:51:50.063] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:50.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:176:0) after 1m0s
[08:52:50.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:176:0)
[08:52:50.177] Timer tick, asking Buildbucket for the build status
[08:52:50.687] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:50.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:177:0) after 1m0s
[08:53:50.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:177:0)
[08:53:50.753] Timer tick, asking Buildbucket for the build status
[08:53:51.200] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:178:0) after 1m0s
[08:54:51.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:178:0)
[08:54:51.272] Timer tick, asking Buildbucket for the build status
[08:54:51.552] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:51.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:179:0) after 1m0s
[08:55:51.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:179:0)
[08:55:51.635] Timer tick, asking Buildbucket for the build status
[08:55:51.946] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:51.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:180:0) after 1m0s
[08:56:51.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:180:0)
[08:56:51.978] Timer tick, asking Buildbucket for the build status
[08:56:53.189] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:53.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:181:0) after 1m0s
[08:57:53.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:181:0)
[08:57:53.273] Timer tick, asking Buildbucket for the build status
[08:57:53.553] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:53.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:182:0) after 1m0s
[08:58:53.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:182:0)
[08:58:53.895] Timer tick, asking Buildbucket for the build status
[08:58:54.157] Build 8896838155677813456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:54.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062268219466744896:183:0) after 1m0s
[08:59:44.512] Received PubSub notification, asking Buildbucket for the build status
[08:59:44.648] Build 8896838155677813456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:59:44.648] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573721983957982",
"created_by": "project:chromium",
"created_ts": "1573710975914293",
"failure_reason": "BUILD_FAILURE",
"id": "8896838155677813456",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890d67c050dca0b2484f028012f1bf817af78d5a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compare_build_artifacts') (retcode: 1)\"}, \"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-t6xr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15197, \"got_angle_revision\": \"1b52f05868c92b0f5e6adb3ccd0d15eac5c77975\", \"got_dawn_revision\": \"321c12255e731a9343b337fd6f5a8bb1c8fa34e5\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"890d67c050dca0b2484f028012f1bf817af78d5a\", \"got_revision_cp\": \"refs/heads/master@{#715196}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b2407dd746decd2418167aa29f1af788cd902904\", \"got_v8_revision\": \"4636c1f0b8ea41d3d8dfe415f16f1022dd194545\", \"got_v8_revision_cp\": \"refs/heads/8.0.256@{#1}\", \"got_webrtc_revision\": \"60bd1aea3d6dc650264ddaeaa0b1f5bce19bb05a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29793}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890d67c050dca0b2484f028012f1bf817af78d5a\"}, \"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-t6xr\"], \"image\": [\"chrome-win10-1703-19102400-d35fedf5a0d\"], \"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\": [\"4628-14f2294\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"Step('compare_build_artifacts') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573711122737650",
"status": "COMPLETED",
"status_changed_ts": "1573711123226395",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15197",
"builder:Windows deterministic",
"buildset:commit/git/890d67c050dca0b2484f028012f1bf817af78d5a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890d67c050dca0b2484f028012f1bf817af78d5a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062268219466744896",
"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/8896838155677813456/+/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:48814d655c383110",
"user_agent:luci-scheduler"
],
"updated_ts": "1573721984047403",
"url": "https://ci.chromium.org/b/8896838155677813456",
"utcnow_ts": "1573721984638990"
}
}
[08:59:44.649] Invocation finished in 3h3m31.731151372s with status FAILED