[16:28:06.419] New invocation is queued and will start shortly
[16:28:07.817] Starting the invocation (attempt 1)
[16:28:07.954] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:28:07.954] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:28:07.954] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062862643079266704",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c87907c6f8780dc2f594c2a619264036a02462b4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9062862643079266704",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/c87907c6f8780dc2f594c2a619264036a02462b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c87907c6f8780dc2f594c2a619264036a02462b4",
"gitiles_ref:refs/heads/master"
]
}
[16:28:10.446] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573144088534321",
"id": "8897432580179469504",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c87907c6f8780dc2f594c2a619264036a02462b4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573144090146703",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15142",
"builder:Windows deterministic",
"buildset:commit/git/c87907c6f8780dc2f594c2a619264036a02462b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c87907c6f8780dc2f594c2a619264036a02462b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062862643079266704",
"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/8897432580179469504/+/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": "1573144090146803",
"url": "https://ci.chromium.org/b/8897432580179469504",
"utcnow_ts": "1573144090435027"
}
}
[16:28:10.446] Task URL: https://ci.chromium.org/b/8897432580179469504
[16:28:10.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:2:0) after 1m0s
[16:28:30.764] Received PubSub notification, asking Buildbucket for the build status
[16:28:30.931] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:10.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:2:0)
[16:29:10.541] Timer tick, asking Buildbucket for the build status
[16:29:11.735] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:11.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:4:0) after 1m0s
[16:30:11.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:4:0)
[16:30:11.877] Timer tick, asking Buildbucket for the build status
[16:30:13.895] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:13.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:5:0) after 1m0s
[16:31:14.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:5:0)
[16:31:14.198] Timer tick, asking Buildbucket for the build status
[16:31:14.398] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:14.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:6:0) after 1m0s
[16:32:14.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:6:0)
[16:32:14.830] Timer tick, asking Buildbucket for the build status
[16:32:15.945] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:15.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:7:0) after 1m0s
[16:33:16.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:7:0)
[16:33:16.011] Timer tick, asking Buildbucket for the build status
[16:33:16.421] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:16.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:8:0) after 1m0s
[16:34:16.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:8:0)
[16:34:16.502] Timer tick, asking Buildbucket for the build status
[16:34:16.758] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:16.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:9:0) after 1m0s
[16:35:16.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:9:0)
[16:35:16.807] Timer tick, asking Buildbucket for the build status
[16:35:16.971] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:16.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:10:0) after 1m0s
[16:36:17.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:10:0)
[16:36:17.000] Timer tick, asking Buildbucket for the build status
[16:36:17.162] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:17.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:11:0) after 1m0s
[16:37:17.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:11:0)
[16:37:17.238] Timer tick, asking Buildbucket for the build status
[16:37:17.547] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:17.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:12:0) after 1m0s
[16:38:17.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:12:0)
[16:38:17.632] Timer tick, asking Buildbucket for the build status
[16:38:20.271] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:20.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:13:0) after 1m0s
[16:39:20.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:13:0)
[16:39:20.314] Timer tick, asking Buildbucket for the build status
[16:39:20.578] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:20.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:14:0) after 1m0s
[16:40:20.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:14:0)
[16:40:20.604] Timer tick, asking Buildbucket for the build status
[16:40:21.095] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:21.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:15:0) after 1m0s
[16:41:21.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:15:0)
[16:41:21.152] Timer tick, asking Buildbucket for the build status
[16:41:24.832] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:24.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:16:0) after 1m0s
[16:42:25.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:16:0)
[16:42:25.006] Timer tick, asking Buildbucket for the build status
[16:42:25.700] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:25.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:17:0) after 1m0s
[16:43:25.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:17:0)
[16:43:25.728] Timer tick, asking Buildbucket for the build status
[16:43:26.000] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:26.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:18:0) after 1m0s
[16:44:26.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:18:0)
[16:44:26.083] Timer tick, asking Buildbucket for the build status
[16:44:26.569] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:26.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:19:0) after 1m0s
[16:45:26.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:19:0)
[16:45:26.567] Timer tick, asking Buildbucket for the build status
[16:45:27.286] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:27.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:20:0) after 1m0s
[16:46:27.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:20:0)
[16:46:27.310] Timer tick, asking Buildbucket for the build status
[16:46:28.158] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:28.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:21:0) after 1m0s
[16:47:28.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:21:0)
[16:47:28.332] Timer tick, asking Buildbucket for the build status
[16:47:28.953] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:28.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:22:0) after 1m0s
[16:48:29.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:22:0)
[16:48:29.201] Timer tick, asking Buildbucket for the build status
[16:48:29.705] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:29.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:23:0) after 1m0s
[16:49:29.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:23:0)
[16:49:29.881] Timer tick, asking Buildbucket for the build status
[16:49:30.524] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:30.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:24:0) after 1m0s
[16:50:30.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:24:0)
[16:50:30.607] Timer tick, asking Buildbucket for the build status
[16:50:31.307] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:31.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:25:0) after 1m0s
[16:51:31.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:25:0)
[16:51:31.352] Timer tick, asking Buildbucket for the build status
[16:51:31.680] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:31.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:26:0) after 1m0s
[16:52:31.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:26:0)
[16:52:31.743] Timer tick, asking Buildbucket for the build status
[16:52:32.019] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:32.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:27:0) after 1m0s
[16:53:32.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:27:0)
[16:53:32.116] Timer tick, asking Buildbucket for the build status
[16:53:32.239] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:32.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:28:0) after 1m0s
[16:54:32.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:28:0)
[16:54:32.253] Timer tick, asking Buildbucket for the build status
[16:54:32.550] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:32.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:29:0) after 1m0s
[16:55:32.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:29:0)
[16:55:32.609] Timer tick, asking Buildbucket for the build status
[16:55:32.902] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:32.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:30:0) after 1m0s
[16:56:32.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:30:0)
[16:56:32.957] Timer tick, asking Buildbucket for the build status
[16:56:38.255] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:38.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:31:0) after 1m0s
[16:57:38.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:31:0)
[16:57:38.289] Timer tick, asking Buildbucket for the build status
[16:57:38.606] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:38.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:32:0) after 1m0s
[16:58:38.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:32:0)
[16:58:38.655] Timer tick, asking Buildbucket for the build status
[16:58:38.850] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:38.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:33:0) after 1m0s
[16:59:38.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:33:0)
[16:59:38.988] Timer tick, asking Buildbucket for the build status
[16:59:39.515] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:39.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:34:0) after 1m0s
[17:00:39.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:34:0)
[17:00:39.563] Timer tick, asking Buildbucket for the build status
[17:00:40.967] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:40.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:35:0) after 1m0s
[17:01:41.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:35:0)
[17:01:41.116] Timer tick, asking Buildbucket for the build status
[17:01:41.379] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:41.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:36:0) after 1m0s
[17:02:41.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:36:0)
[17:02:41.424] Timer tick, asking Buildbucket for the build status
[17:02:41.645] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:41.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:37:0) after 1m0s
[17:03:41.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:37:0)
[17:03:41.663] Timer tick, asking Buildbucket for the build status
[17:03:42.259] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:42.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:38:0) after 1m0s
[17:04:42.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:38:0)
[17:04:42.310] Timer tick, asking Buildbucket for the build status
[17:04:42.942] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:42.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:39:0) after 1m0s
[17:05:43.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:39:0)
[17:05:43.009] Timer tick, asking Buildbucket for the build status
[17:05:43.496] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:43.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:40:0) after 1m0s
[17:06:43.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:40:0)
[17:06:43.684] Timer tick, asking Buildbucket for the build status
[17:06:43.862] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:43.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:41:0) after 1m0s
[17:07:43.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:41:0)
[17:07:43.934] Timer tick, asking Buildbucket for the build status
[17:07:44.641] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:44.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:42:0) after 1m0s
[17:08:44.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:42:0)
[17:08:44.693] Timer tick, asking Buildbucket for the build status
[17:08:44.934] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:44.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:43:0) after 1m0s
[17:09:45.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:43:0)
[17:09:45.005] Timer tick, asking Buildbucket for the build status
[17:09:45.448] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:45.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:44:0) after 1m0s
[17:10:45.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:44:0)
[17:10:45.472] Timer tick, asking Buildbucket for the build status
[17:10:45.746] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:45.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:45:0) after 1m0s
[17:11:45.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:45:0)
[17:11:45.853] Timer tick, asking Buildbucket for the build status
[17:11:46.626] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:46.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:46:0) after 1m0s
[17:12:46.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:46:0)
[17:12:46.718] Timer tick, asking Buildbucket for the build status
[17:12:48.108] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:48.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:47:0) after 1m0s
[17:13:48.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:47:0)
[17:13:48.308] Timer tick, asking Buildbucket for the build status
[17:13:48.976] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:48.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:48:0) after 1m0s
[17:14:49.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:48:0)
[17:14:49.022] Timer tick, asking Buildbucket for the build status
[17:14:49.390] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:49.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:49:0) after 1m0s
[17:15:49.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:49:0)
[17:15:49.424] Timer tick, asking Buildbucket for the build status
[17:15:49.926] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:49.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:50:0) after 1m0s
[17:16:49.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:50:0)
[17:16:49.961] Timer tick, asking Buildbucket for the build status
[17:16:50.285] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:50.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:51:0) after 1m0s
[17:17:50.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:51:0)
[17:17:50.313] Timer tick, asking Buildbucket for the build status
[17:17:51.082] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:51.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:52:0) after 1m0s
[17:18:51.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:52:0)
[17:18:51.163] Timer tick, asking Buildbucket for the build status
[17:18:51.990] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:51.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:53:0) after 1m0s
[17:19:51.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:53:0)
[17:19:51.981] Timer tick, asking Buildbucket for the build status
[17:19:53.102] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:53.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:54:0) after 1m0s
[17:20:53.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:54:0)
[17:20:53.571] Timer tick, asking Buildbucket for the build status
[17:20:53.729] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:55:0) after 1m0s
[17:21:54.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:55:0)
[17:21:54.122] Timer tick, asking Buildbucket for the build status
[17:21:54.374] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:54.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:56:0) after 1m0s
[17:22:54.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:56:0)
[17:22:54.450] Timer tick, asking Buildbucket for the build status
[17:22:54.701] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:54.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:57:0) after 1m0s
[17:23:54.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:57:0)
[17:23:54.773] Timer tick, asking Buildbucket for the build status
[17:23:55.303] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:55.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:58:0) after 1m0s
[17:24:55.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:58:0)
[17:24:55.553] Timer tick, asking Buildbucket for the build status
[17:24:55.825] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:55.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:59:0) after 1m0s
[17:25:55.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:59:0)
[17:25:55.929] Timer tick, asking Buildbucket for the build status
[17:25:56.078] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:56.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:60:0) after 1m0s
[17:26:56.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:60:0)
[17:26:56.093] Timer tick, asking Buildbucket for the build status
[17:26:56.814] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:56.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:61:0) after 1m0s
[17:27:56.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:61:0)
[17:27:56.895] Timer tick, asking Buildbucket for the build status
[17:27:57.117] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:57.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:62:0) after 1m0s
[17:28:57.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:62:0)
[17:28:57.267] Timer tick, asking Buildbucket for the build status
[17:28:57.905] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:57.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:63:0) after 1m0s
[17:29:57.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:63:0)
[17:29:57.981] Timer tick, asking Buildbucket for the build status
[17:29:58.600] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:58.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:64:0) after 1m0s
[17:30:58.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:64:0)
[17:30:58.683] Timer tick, asking Buildbucket for the build status
[17:30:59.692] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:59.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:65:0) after 1m0s
[17:31:59.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:65:0)
[17:31:59.795] Timer tick, asking Buildbucket for the build status
[17:32:00.084] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:00.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:66:0) after 1m0s
[17:33:00.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:66:0)
[17:33:00.165] Timer tick, asking Buildbucket for the build status
[17:33:02.497] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:02.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:67:0) after 1m0s
[17:34:02.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:67:0)
[17:34:02.517] Timer tick, asking Buildbucket for the build status
[17:34:03.011] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:03.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:68:0) after 1m0s
[17:35:03.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:68:0)
[17:35:03.049] Timer tick, asking Buildbucket for the build status
[17:35:03.313] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:03.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:69:0) after 1m0s
[17:36:03.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:69:0)
[17:36:03.460] Timer tick, asking Buildbucket for the build status
[17:36:05.170] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:05.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:70:0) after 1m0s
[17:37:05.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:70:0)
[17:37:05.183] Timer tick, asking Buildbucket for the build status
[17:37:05.457] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:05.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:71:0) after 1m0s
[17:38:05.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:71:0)
[17:38:05.513] Timer tick, asking Buildbucket for the build status
[17:38:05.751] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:05.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:72:0) after 1m0s
[17:39:05.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:72:0)
[17:39:05.924] Timer tick, asking Buildbucket for the build status
[17:39:06.178] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:06.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:73:0) after 1m0s
[17:40:06.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:73:0)
[17:40:06.514] Timer tick, asking Buildbucket for the build status
[17:40:06.712] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:06.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:74:0) after 1m0s
[17:41:06.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:74:0)
[17:41:06.833] Timer tick, asking Buildbucket for the build status
[17:41:07.143] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:07.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:75:0) after 1m0s
[17:42:07.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:75:0)
[17:42:07.543] Timer tick, asking Buildbucket for the build status
[17:42:08.291] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:08.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:76:0) after 1m0s
[17:43:08.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:76:0)
[17:43:08.421] Timer tick, asking Buildbucket for the build status
[17:43:10.831] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:10.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:77:0) after 1m0s
[17:44:10.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:77:0)
[17:44:10.912] Timer tick, asking Buildbucket for the build status
[17:44:11.241] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:11.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:78:0) after 1m0s
[17:45:11.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:78:0)
[17:45:11.280] Timer tick, asking Buildbucket for the build status
[17:45:11.527] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:11.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:79:0) after 1m0s
[17:46:11.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:79:0)
[17:46:11.559] Timer tick, asking Buildbucket for the build status
[17:46:11.671] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:11.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:80:0) after 1m0s
[17:47:11.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:80:0)
[17:47:11.977] Timer tick, asking Buildbucket for the build status
[17:47:13.077] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:13.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:81:0) after 1m0s
[17:48:13.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:81:0)
[17:48:13.236] Timer tick, asking Buildbucket for the build status
[17:48:13.811] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:13.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:82:0) after 1m0s
[17:49:13.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:82:0)
[17:49:13.937] Timer tick, asking Buildbucket for the build status
[17:49:14.251] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:14.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:83:0) after 1m0s
[17:50:14.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:83:0)
[17:50:14.283] Timer tick, asking Buildbucket for the build status
[17:50:15.001] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:15.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:84:0) after 1m0s
[17:51:18.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:84:0)
[17:51:18.018] Timer tick, asking Buildbucket for the build status
[17:51:18.351] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:18.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:85:0) after 1m0s
[17:52:18.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:85:0)
[17:52:18.378] Timer tick, asking Buildbucket for the build status
[17:52:19.802] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:19.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:86:0) after 1m0s
[17:53:19.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:86:0)
[17:53:19.844] Timer tick, asking Buildbucket for the build status
[17:53:20.199] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:87:0) after 1m0s
[17:54:20.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:87:0)
[17:54:20.261] Timer tick, asking Buildbucket for the build status
[17:54:20.543] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:20.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:88:0) after 1m0s
[17:55:20.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:88:0)
[17:55:20.577] Timer tick, asking Buildbucket for the build status
[17:55:20.886] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:20.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:89:0) after 1m0s
[17:56:20.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:89:0)
[17:56:20.915] Timer tick, asking Buildbucket for the build status
[17:56:25.242] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:25.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:90:0) after 1m0s
[17:57:25.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:90:0)
[17:57:25.345] Timer tick, asking Buildbucket for the build status
[17:57:25.488] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:25.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:91:0) after 1m0s
[17:58:25.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:91:0)
[17:58:25.571] Timer tick, asking Buildbucket for the build status
[17:58:25.917] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:25.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:92:0) after 1m0s
[17:59:25.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:92:0)
[17:59:25.919] Timer tick, asking Buildbucket for the build status
[17:59:26.617] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:26.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:93:0) after 1m0s
[18:00:26.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:93:0)
[18:00:26.691] Timer tick, asking Buildbucket for the build status
[18:00:27.549] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:27.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:94:0) after 1m0s
[18:01:27.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:94:0)
[18:01:27.611] Timer tick, asking Buildbucket for the build status
[18:01:27.865] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:27.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:95:0) after 1m0s
[18:02:27.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:95:0)
[18:02:27.952] Timer tick, asking Buildbucket for the build status
[18:02:30.065] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:30.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:96:0) after 1m0s
[18:03:30.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:96:0)
[18:03:30.109] Timer tick, asking Buildbucket for the build status
[18:03:30.430] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:30.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:97:0) after 1m0s
[18:04:30.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:97:0)
[18:04:30.487] Timer tick, asking Buildbucket for the build status
[18:04:33.866] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:33.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:98:0) after 1m0s
[18:05:33.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:98:0)
[18:05:33.954] Timer tick, asking Buildbucket for the build status
[18:05:39.012] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:39.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:99:0) after 1m0s
[18:06:39.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:99:0)
[18:06:39.013] Timer tick, asking Buildbucket for the build status
[18:06:39.672] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:39.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:100:0) after 1m0s
[18:07:39.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:100:0)
[18:07:39.692] Timer tick, asking Buildbucket for the build status
[18:07:43.682] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:43.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:101:0) after 1m0s
[18:08:43.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:101:0)
[18:08:43.973] Timer tick, asking Buildbucket for the build status
[18:08:45.026] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:45.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:102:0) after 1m0s
[18:09:45.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:102:0)
[18:09:45.420] Timer tick, asking Buildbucket for the build status
[18:09:47.251] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:47.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:103:0) after 1m0s
[18:10:47.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:103:0)
[18:10:47.405] Timer tick, asking Buildbucket for the build status
[18:10:47.683] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:47.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:104:0) after 1m0s
[18:11:47.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:104:0)
[18:11:47.744] Timer tick, asking Buildbucket for the build status
[18:11:49.604] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:49.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:105:0) after 1m0s
[18:12:49.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:105:0)
[18:12:49.635] Timer tick, asking Buildbucket for the build status
[18:12:50.316] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:50.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:106:0) after 1m0s
[18:13:50.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:106:0)
[18:13:50.430] Timer tick, asking Buildbucket for the build status
[18:13:50.652] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:50.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:107:0) after 1m0s
[18:14:50.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:107:0)
[18:14:50.766] Timer tick, asking Buildbucket for the build status
[18:14:51.295] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:51.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:108:0) after 1m0s
[18:15:51.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:108:0)
[18:15:51.445] Timer tick, asking Buildbucket for the build status
[18:15:51.675] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:51.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:109:0) after 1m0s
[18:16:51.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:109:0)
[18:16:51.727] Timer tick, asking Buildbucket for the build status
[18:16:54.629] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:54.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:110:0) after 1m0s
[18:17:54.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:110:0)
[18:17:54.734] Timer tick, asking Buildbucket for the build status
[18:17:55.013] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:55.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:111:0) after 1m0s
[18:18:55.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:111:0)
[18:18:55.109] Timer tick, asking Buildbucket for the build status
[18:18:57.381] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:57.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:112:0) after 1m0s
[18:19:57.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:112:0)
[18:19:57.407] Timer tick, asking Buildbucket for the build status
[18:19:57.806] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:57.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:113:0) after 1m0s
[18:20:57.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:113:0)
[18:20:57.841] Timer tick, asking Buildbucket for the build status
[18:21:00.397] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:00.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:114:0) after 1m0s
[18:22:00.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:114:0)
[18:22:00.422] Timer tick, asking Buildbucket for the build status
[18:22:01.296] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:01.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:115:0) after 1m0s
[18:23:01.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:115:0)
[18:23:01.360] Timer tick, asking Buildbucket for the build status
[18:23:01.755] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:01.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:116:0) after 1m0s
[18:24:01.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:116:0)
[18:24:01.782] Timer tick, asking Buildbucket for the build status
[18:24:02.232] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:02.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:117:0) after 1m0s
[18:25:02.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:117:0)
[18:25:02.404] Timer tick, asking Buildbucket for the build status
[18:25:05.430] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:05.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:118:0) after 1m0s
[18:26:05.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:118:0)
[18:26:05.509] Timer tick, asking Buildbucket for the build status
[18:26:06.132] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:06.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:119:0) after 1m0s
[18:27:06.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:119:0)
[18:27:06.246] Timer tick, asking Buildbucket for the build status
[18:27:06.627] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:06.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:120:0) after 1m0s
[18:28:06.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:120:0)
[18:28:06.640] Timer tick, asking Buildbucket for the build status
[18:28:07.429] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:07.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:121:0) after 1m0s
[18:29:07.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:121:0)
[18:29:07.517] Timer tick, asking Buildbucket for the build status
[18:29:08.823] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:08.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:122:0) after 1m0s
[18:30:08.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:122:0)
[18:30:08.957] Timer tick, asking Buildbucket for the build status
[18:30:09.273] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:09.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:123:0) after 1m0s
[18:31:09.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:123:0)
[18:31:09.322] Timer tick, asking Buildbucket for the build status
[18:31:12.471] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:12.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:124:0) after 1m0s
[18:32:12.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:124:0)
[18:32:12.508] Timer tick, asking Buildbucket for the build status
[18:32:12.755] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:12.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:125:0) after 1m0s
[18:33:12.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:125:0)
[18:33:12.914] Timer tick, asking Buildbucket for the build status
[18:33:13.557] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:13.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:126:0) after 1m0s
[18:34:13.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:126:0)
[18:34:13.574] Timer tick, asking Buildbucket for the build status
[18:34:14.500] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:14.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:127:0) after 1m0s
[18:35:14.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:127:0)
[18:35:14.558] Timer tick, asking Buildbucket for the build status
[18:35:15.083] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:15.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:128:0) after 1m0s
[18:36:15.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:128:0)
[18:36:15.174] Timer tick, asking Buildbucket for the build status
[18:36:15.721] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:15.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:129:0) after 1m0s
[18:37:15.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:129:0)
[18:37:15.794] Timer tick, asking Buildbucket for the build status
[18:37:16.289] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:16.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:130:0) after 1m0s
[18:38:16.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:130:0)
[18:38:16.313] Timer tick, asking Buildbucket for the build status
[18:38:16.810] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:16.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:131:0) after 1m0s
[18:39:16.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:131:0)
[18:39:16.877] Timer tick, asking Buildbucket for the build status
[18:39:19.103] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:19.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:132:0) after 1m0s
[18:40:19.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:132:0)
[18:40:19.170] Timer tick, asking Buildbucket for the build status
[18:40:19.475] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:19.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:133:0) after 1m0s
[18:41:19.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:133:0)
[18:41:19.480] Timer tick, asking Buildbucket for the build status
[18:41:21.580] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:21.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:134:0) after 1m0s
[18:42:21.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:134:0)
[18:42:21.640] Timer tick, asking Buildbucket for the build status
[18:42:24.261] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:135:0) after 1m0s
[18:43:24.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:135:0)
[18:43:24.322] Timer tick, asking Buildbucket for the build status
[18:43:24.595] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:24.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:136:0) after 1m0s
[18:44:24.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:136:0)
[18:44:24.672] Timer tick, asking Buildbucket for the build status
[18:44:25.428] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:25.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:137:0) after 1m0s
[18:45:25.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:137:0)
[18:45:25.526] Timer tick, asking Buildbucket for the build status
[18:45:25.714] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:25.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:138:0) after 1m0s
[18:46:25.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:138:0)
[18:46:25.725] Timer tick, asking Buildbucket for the build status
[18:46:26.390] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:26.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:139:0) after 1m0s
[18:47:26.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:139:0)
[18:47:26.441] Timer tick, asking Buildbucket for the build status
[18:47:29.470] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:29.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:140:0) after 1m0s
[18:48:29.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:140:0)
[18:48:29.616] Timer tick, asking Buildbucket for the build status
[18:48:32.512] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:32.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:141:0) after 1m0s
[18:49:32.587] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:141:0)
[18:49:32.587] Timer tick, asking Buildbucket for the build status
[18:49:33.561] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:33.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:142:0) after 1m0s
[18:50:33.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:142:0)
[18:50:33.707] Timer tick, asking Buildbucket for the build status
[18:50:34.445] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:34.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:143:0) after 1m0s
[18:51:34.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:143:0)
[18:51:34.527] Timer tick, asking Buildbucket for the build status
[18:51:35.322] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:35.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:144:0) after 1m0s
[18:52:35.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:144:0)
[18:52:35.424] Timer tick, asking Buildbucket for the build status
[18:52:35.665] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:35.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:145:0) after 1m0s
[18:53:35.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:145:0)
[18:53:35.736] Timer tick, asking Buildbucket for the build status
[18:53:35.974] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:35.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:146:0) after 1m0s
[18:54:35.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:146:0)
[18:54:35.990] Timer tick, asking Buildbucket for the build status
[18:54:36.224] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:36.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:147:0) after 1m0s
[18:55:36.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:147:0)
[18:55:36.276] Timer tick, asking Buildbucket for the build status
[18:55:37.787] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:37.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:148:0) after 1m0s
[18:56:37.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:148:0)
[18:56:37.938] Timer tick, asking Buildbucket for the build status
[18:56:38.799] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:38.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:149:0) after 1m0s
[18:57:38.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:149:0)
[18:57:38.846] Timer tick, asking Buildbucket for the build status
[18:57:39.026] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:39.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:150:0) after 1m0s
[18:58:39.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:150:0)
[18:58:39.066] Timer tick, asking Buildbucket for the build status
[18:58:39.702] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:39.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:151:0) after 1m0s
[18:59:39.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:151:0)
[18:59:39.825] Timer tick, asking Buildbucket for the build status
[18:59:41.832] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:41.833] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:152:0) after 1m0s
[19:00:42.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:152:0)
[19:00:42.008] Timer tick, asking Buildbucket for the build status
[19:00:42.152] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:42.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:153:0) after 1m0s
[19:01:42.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:153:0)
[19:01:42.203] Timer tick, asking Buildbucket for the build status
[19:01:42.628] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:42.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:154:0) after 1m0s
[19:02:42.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:154:0)
[19:02:42.697] Timer tick, asking Buildbucket for the build status
[19:02:43.031] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:43.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:155:0) after 1m0s
[19:03:43.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:155:0)
[19:03:43.074] Timer tick, asking Buildbucket for the build status
[19:03:43.689] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:43.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:156:0) after 1m0s
[19:04:43.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:156:0)
[19:04:43.714] Timer tick, asking Buildbucket for the build status
[19:04:47.494] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:47.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:157:0) after 1m0s
[19:05:47.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:157:0)
[19:05:47.531] Timer tick, asking Buildbucket for the build status
[19:05:47.780] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:47.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:158:0) after 1m0s
[19:06:47.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:158:0)
[19:06:47.853] Timer tick, asking Buildbucket for the build status
[19:06:48.289] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:48.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:159:0) after 1m0s
[19:07:48.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:159:0)
[19:07:48.483] Timer tick, asking Buildbucket for the build status
[19:07:48.682] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:48.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:160:0) after 1m0s
[19:08:48.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:160:0)
[19:08:48.716] Timer tick, asking Buildbucket for the build status
[19:08:51.436] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:51.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:161:0) after 1m0s
[19:09:51.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:161:0)
[19:09:51.499] Timer tick, asking Buildbucket for the build status
[19:09:51.954] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:51.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:162:0) after 1m0s
[19:10:52.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:162:0)
[19:10:52.004] Timer tick, asking Buildbucket for the build status
[19:10:52.365] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:52.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:163:0) after 1m0s
[19:11:52.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:163:0)
[19:11:52.420] Timer tick, asking Buildbucket for the build status
[19:11:52.624] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:52.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:164:0) after 1m0s
[19:12:52.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:164:0)
[19:12:52.838] Timer tick, asking Buildbucket for the build status
[19:12:53.421] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:53.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:165:0) after 1m0s
[19:13:53.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:165:0)
[19:13:53.477] Timer tick, asking Buildbucket for the build status
[19:13:54.937] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:54.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:166:0) after 1m0s
[19:14:55.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:166:0)
[19:14:55.004] Timer tick, asking Buildbucket for the build status
[19:14:56.243] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:56.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:167:0) after 1m0s
[19:15:56.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:167:0)
[19:15:56.267] Timer tick, asking Buildbucket for the build status
[19:15:56.792] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:56.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:168:0) after 1m0s
[19:16:56.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:168:0)
[19:16:56.911] Timer tick, asking Buildbucket for the build status
[19:16:57.442] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:57.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:169:0) after 1m0s
[19:17:57.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:169:0)
[19:17:57.514] Timer tick, asking Buildbucket for the build status
[19:17:57.653] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:57.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:170:0) after 1m0s
[19:18:57.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:170:0)
[19:18:57.729] Timer tick, asking Buildbucket for the build status
[19:18:58.098] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:58.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:171:0) after 1m0s
[19:19:58.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:171:0)
[19:19:58.104] Timer tick, asking Buildbucket for the build status
[19:19:58.703] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:58.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:172:0) after 1m0s
[19:20:58.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:172:0)
[19:20:58.715] Timer tick, asking Buildbucket for the build status
[19:20:59.579] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:59.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:173:0) after 1m0s
[19:21:59.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:173:0)
[19:21:59.605] Timer tick, asking Buildbucket for the build status
[19:22:00.135] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:174:0) after 1m0s
[19:23:00.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:174:0)
[19:23:00.169] Timer tick, asking Buildbucket for the build status
[19:23:00.379] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:00.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:175:0) after 1m0s
[19:24:00.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:175:0)
[19:24:00.478] Timer tick, asking Buildbucket for the build status
[19:24:00.670] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:00.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:176:0) after 1m0s
[19:25:00.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:176:0)
[19:25:00.783] Timer tick, asking Buildbucket for the build status
[19:25:02.236] Build 8897432580179469504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:02.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9062862643079266704:177:0) after 1m0s
[19:25:32.141] Received PubSub notification, asking Buildbucket for the build status
[19:25:32.282] Build 8897432580179469504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:25:32.282] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573154731018393",
"created_by": "project:chromium",
"created_ts": "1573144088534321",
"id": "8897432580179469504",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c87907c6f8780dc2f594c2a619264036a02462b4\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-xdeu\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15142, \"got_angle_revision\": \"075cc4c355a64c7d053bd4249eca2dc9a8d29a90\", \"got_dawn_revision\": \"252d1eb47f23beb379bdbb47bf04ef4a71b660a8\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"c87907c6f8780dc2f594c2a619264036a02462b4\", \"got_revision_cp\": \"refs/heads/master@{#713451}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"27a3d31d7a9d65bb49b83da404cc4830eb3ce06e\", \"got_v8_revision\": \"df4d2dedd74285da86175275845bbea74b4afcfc\", \"got_v8_revision_cp\": \"refs/heads/8.0.192@{#1}\", \"got_webrtc_revision\": \"8caa67635d2c6b49153d5753cdeec48e95154b32\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29722}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c87907c6f8780dc2f594c2a619264036a02462b4\"}, \"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-xdeu\"], \"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\": [\"4621-f8a5b1c\"], \"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": "1573144109872421",
"status": "COMPLETED",
"status_changed_ts": "1573154731529185",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15142",
"builder:Windows deterministic",
"buildset:commit/git/c87907c6f8780dc2f594c2a619264036a02462b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c87907c6f8780dc2f594c2a619264036a02462b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062862643079266704",
"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/8897432580179469504/+/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:485f838c04b1e410",
"user_agent:luci-scheduler"
],
"updated_ts": "1573154731537638",
"url": "https://ci.chromium.org/b/8897432580179469504",
"utcnow_ts": "1573154732272397"
}
}
[19:25:32.282] Invocation finished in 2h57m25.896485765s with status SUCCEEDED