[20:30:22.397] New invocation is queued and will start shortly
[20:30:23.814] Starting the invocation (attempt 1)
[20:30:23.862] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:23.862] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:23.862] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069460979556437376",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9069460979556437376",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f",
"gitiles_ref:refs/heads/master"
]
}
[20:30:25.664] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566851424091966",
"id": "8904030917091128928",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566851425351908",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14547",
"builder:Windows deterministic",
"buildset:commit/git/9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069460979556437376",
"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/8904030917091128928/+/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": "1566851425352039",
"url": "https://ci.chromium.org/b/8904030917091128928",
"utcnow_ts": "1566851425647749"
}
}
[20:30:25.664] Task URL: https://ci.chromium.org/b/8904030917091128928
[20:30:25.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:2:0) after 1m0s
[20:31:25.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:2:0)
[20:31:25.679] Timer tick, asking Buildbucket for the build status
[20:31:28.017] Build 8904030917091128928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:28.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:3:0) after 1m0s
[20:32:27.660] Received PubSub notification, asking Buildbucket for the build status
[20:32:28.672] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:33.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:3:0)
[20:32:33.276] Timer tick, asking Buildbucket for the build status
[20:32:34.711] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:34.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:5:0) after 1m0s
[20:33:35.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:5:0)
[20:33:35.518] Timer tick, asking Buildbucket for the build status
[20:33:36.331] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:36.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:6:0) after 1m0s
[20:34:36.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:6:0)
[20:34:36.503] Timer tick, asking Buildbucket for the build status
[20:34:36.722] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:7:0) after 1m0s
[20:35:37.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:7:0)
[20:35:37.037] Timer tick, asking Buildbucket for the build status
[20:35:37.268] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:37.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:8:0) after 1m0s
[20:36:37.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:8:0)
[20:36:37.454] Timer tick, asking Buildbucket for the build status
[20:36:38.172] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:38.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:9:0) after 1m0s
[20:37:38.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:9:0)
[20:37:38.281] Timer tick, asking Buildbucket for the build status
[20:37:38.558] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:38.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:10:0) after 1m0s
[20:38:38.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:10:0)
[20:38:38.767] Timer tick, asking Buildbucket for the build status
[20:38:39.309] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:39.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:11:0) after 1m0s
[20:39:39.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:11:0)
[20:39:39.368] Timer tick, asking Buildbucket for the build status
[20:39:39.823] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:39.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:12:0) after 1m0s
[20:40:39.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:12:0)
[20:40:39.908] Timer tick, asking Buildbucket for the build status
[20:40:40.102] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:40.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:13:0) after 1m0s
[20:41:40.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:13:0)
[20:41:40.362] Timer tick, asking Buildbucket for the build status
[20:41:41.085] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:41.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:14:0) after 1m0s
[20:42:41.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:14:0)
[20:42:41.344] Timer tick, asking Buildbucket for the build status
[20:42:41.866] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:41.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:15:0) after 1m0s
[20:43:42.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:15:0)
[20:43:42.221] Timer tick, asking Buildbucket for the build status
[20:43:42.859] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:42.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:16:0) after 1m0s
[20:44:42.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:16:0)
[20:44:42.885] Timer tick, asking Buildbucket for the build status
[20:44:44.351] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:44.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:17:0) after 1m0s
[20:45:44.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:17:0)
[20:45:44.346] Timer tick, asking Buildbucket for the build status
[20:45:44.910] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:44.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:18:0) after 1m0s
[20:46:44.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:18:0)
[20:46:44.981] Timer tick, asking Buildbucket for the build status
[20:46:47.716] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:47.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:19:0) after 1m0s
[20:47:47.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:19:0)
[20:47:47.730] Timer tick, asking Buildbucket for the build status
[20:47:48.143] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:48.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:20:0) after 1m0s
[20:48:48.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:20:0)
[20:48:48.183] Timer tick, asking Buildbucket for the build status
[20:48:48.578] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:48.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:21:0) after 1m0s
[20:49:48.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:21:0)
[20:49:48.635] Timer tick, asking Buildbucket for the build status
[20:49:49.072] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:49.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:22:0) after 1m0s
[20:50:49.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:22:0)
[20:50:49.149] Timer tick, asking Buildbucket for the build status
[20:50:49.382] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:49.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:23:0) after 1m0s
[20:51:49.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:23:0)
[20:51:49.427] Timer tick, asking Buildbucket for the build status
[20:51:49.631] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:49.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:24:0) after 1m0s
[20:52:49.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:24:0)
[20:52:49.715] Timer tick, asking Buildbucket for the build status
[20:52:50.496] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:50.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:25:0) after 1m0s
[20:53:50.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:25:0)
[20:53:50.532] Timer tick, asking Buildbucket for the build status
[20:53:50.863] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:50.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:26:0) after 1m0s
[20:54:50.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:26:0)
[20:54:50.901] Timer tick, asking Buildbucket for the build status
[20:54:51.090] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:51.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:27:0) after 1m0s
[20:55:51.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:27:0)
[20:55:51.141] Timer tick, asking Buildbucket for the build status
[20:55:51.448] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:28:0) after 1m0s
[20:56:51.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:28:0)
[20:56:51.545] Timer tick, asking Buildbucket for the build status
[20:56:54.278] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:54.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:29:0) after 1m0s
[20:57:54.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:29:0)
[20:57:54.488] Timer tick, asking Buildbucket for the build status
[20:57:55.304] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:55.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:30:0) after 1m0s
[20:58:55.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:30:0)
[20:58:55.385] Timer tick, asking Buildbucket for the build status
[20:58:55.643] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:55.643] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:31:0) after 1m0s
[20:59:55.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:31:0)
[20:59:55.652] Timer tick, asking Buildbucket for the build status
[20:59:55.965] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:55.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:32:0) after 1m0s
[21:00:56.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:32:0)
[21:00:56.000] Timer tick, asking Buildbucket for the build status
[21:00:56.780] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:56.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:33:0) after 1m0s
[21:01:56.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:33:0)
[21:01:56.868] Timer tick, asking Buildbucket for the build status
[21:01:58.599] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:58.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:34:0) after 1m0s
[21:02:58.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:34:0)
[21:02:58.629] Timer tick, asking Buildbucket for the build status
[21:02:58.964] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:58.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:35:0) after 1m0s
[21:03:59.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:35:0)
[21:03:59.025] Timer tick, asking Buildbucket for the build status
[21:04:00.028] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:00.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:36:0) after 1m0s
[21:05:00.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:36:0)
[21:05:00.087] Timer tick, asking Buildbucket for the build status
[21:05:02.287] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:37:0) after 1m0s
[21:06:02.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:37:0)
[21:06:02.358] Timer tick, asking Buildbucket for the build status
[21:06:03.417] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:03.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:38:0) after 1m0s
[21:07:03.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:38:0)
[21:07:03.524] Timer tick, asking Buildbucket for the build status
[21:07:03.944] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:03.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:39:0) after 1m0s
[21:08:04.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:39:0)
[21:08:04.242] Timer tick, asking Buildbucket for the build status
[21:08:04.654] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:04.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:40:0) after 1m0s
[21:09:04.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:40:0)
[21:09:04.782] Timer tick, asking Buildbucket for the build status
[21:09:05.106] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:05.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:41:0) after 1m0s
[21:10:05.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:41:0)
[21:10:05.268] Timer tick, asking Buildbucket for the build status
[21:10:05.572] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:05.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:42:0) after 1m0s
[21:11:05.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:42:0)
[21:11:05.643] Timer tick, asking Buildbucket for the build status
[21:11:06.807] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:06.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:43:0) after 1m0s
[21:12:06.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:43:0)
[21:12:06.850] Timer tick, asking Buildbucket for the build status
[21:12:07.112] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:07.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:44:0) after 1m0s
[21:13:07.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:44:0)
[21:13:07.163] Timer tick, asking Buildbucket for the build status
[21:13:07.901] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:07.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:45:0) after 1m0s
[21:14:07.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:45:0)
[21:14:07.970] Timer tick, asking Buildbucket for the build status
[21:14:08.282] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:08.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:46:0) after 1m0s
[21:15:08.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:46:0)
[21:15:08.421] Timer tick, asking Buildbucket for the build status
[21:15:08.782] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:08.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:47:0) after 1m0s
[21:16:08.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:47:0)
[21:16:08.840] Timer tick, asking Buildbucket for the build status
[21:16:08.976] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:08.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:48:0) after 1m0s
[21:17:09.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:48:0)
[21:17:09.027] Timer tick, asking Buildbucket for the build status
[21:17:09.216] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:09.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:49:0) after 1m0s
[21:18:09.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:49:0)
[21:18:09.524] Timer tick, asking Buildbucket for the build status
[21:18:09.754] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:09.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:50:0) after 1m0s
[21:19:09.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:50:0)
[21:19:09.846] Timer tick, asking Buildbucket for the build status
[21:19:12.995] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:12.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:51:0) after 1m0s
[21:20:13.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:51:0)
[21:20:13.079] Timer tick, asking Buildbucket for the build status
[21:20:15.490] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:15.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:52:0) after 1m0s
[21:21:15.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:52:0)
[21:21:15.515] Timer tick, asking Buildbucket for the build status
[21:21:16.204] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:16.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:53:0) after 1m0s
[21:22:16.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:53:0)
[21:22:16.229] Timer tick, asking Buildbucket for the build status
[21:22:17.243] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:17.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:54:0) after 1m0s
[21:23:17.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:54:0)
[21:23:17.344] Timer tick, asking Buildbucket for the build status
[21:23:18.129] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:18.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:55:0) after 1m0s
[21:24:18.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:55:0)
[21:24:18.163] Timer tick, asking Buildbucket for the build status
[21:24:19.326] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:19.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:56:0) after 1m0s
[21:25:19.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:56:0)
[21:25:19.339] Timer tick, asking Buildbucket for the build status
[21:25:21.073] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:21.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:57:0) after 1m0s
[21:26:21.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:57:0)
[21:26:21.111] Timer tick, asking Buildbucket for the build status
[21:26:22.835] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:22.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:58:0) after 1m0s
[21:27:22.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:58:0)
[21:27:22.876] Timer tick, asking Buildbucket for the build status
[21:27:24.054] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:24.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:59:0) after 1m0s
[21:28:24.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:59:0)
[21:28:24.076] Timer tick, asking Buildbucket for the build status
[21:28:25.023] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:25.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:60:0) after 1m0s
[21:29:25.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:60:0)
[21:29:25.093] Timer tick, asking Buildbucket for the build status
[21:29:25.271] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:25.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:61:0) after 1m0s
[21:30:25.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:61:0)
[21:30:25.293] Timer tick, asking Buildbucket for the build status
[21:30:25.677] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:25.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:62:0) after 1m0s
[21:31:25.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:62:0)
[21:31:25.709] Timer tick, asking Buildbucket for the build status
[21:31:26.199] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:26.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:63:0) after 1m0s
[21:32:26.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:63:0)
[21:32:26.210] Timer tick, asking Buildbucket for the build status
[21:32:26.687] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:26.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:64:0) after 1m0s
[21:33:27.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:64:0)
[21:33:27.068] Timer tick, asking Buildbucket for the build status
[21:33:27.613] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:27.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:65:0) after 1m0s
[21:34:27.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:65:0)
[21:34:27.862] Timer tick, asking Buildbucket for the build status
[21:34:28.720] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:28.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:66:0) after 1m0s
[21:35:28.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:66:0)
[21:35:28.713] Timer tick, asking Buildbucket for the build status
[21:35:29.759] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:29.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:67:0) after 1m0s
[21:36:29.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:67:0)
[21:36:29.845] Timer tick, asking Buildbucket for the build status
[21:36:34.720] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:34.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:68:0) after 1m0s
[21:37:34.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:68:0)
[21:37:34.777] Timer tick, asking Buildbucket for the build status
[21:37:35.540] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:35.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:69:0) after 1m0s
[21:38:35.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:69:0)
[21:38:35.602] Timer tick, asking Buildbucket for the build status
[21:38:38.865] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:38.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:70:0) after 1m0s
[21:39:38.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:70:0)
[21:39:38.913] Timer tick, asking Buildbucket for the build status
[21:39:42.932] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:42.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:71:0) after 1m0s
[21:40:42.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:71:0)
[21:40:42.979] Timer tick, asking Buildbucket for the build status
[21:40:44.621] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:44.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:72:0) after 1m0s
[21:41:44.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:72:0)
[21:41:44.692] Timer tick, asking Buildbucket for the build status
[21:41:46.193] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:46.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:73:0) after 1m0s
[21:42:46.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:73:0)
[21:42:46.198] Timer tick, asking Buildbucket for the build status
[21:42:47.252] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:47.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:74:0) after 1m0s
[21:43:47.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:74:0)
[21:43:47.272] Timer tick, asking Buildbucket for the build status
[21:43:47.459] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:47.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:75:0) after 1m0s
[21:44:47.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:75:0)
[21:44:47.484] Timer tick, asking Buildbucket for the build status
[21:44:47.779] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:47.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:76:0) after 1m0s
[21:45:47.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:76:0)
[21:45:47.829] Timer tick, asking Buildbucket for the build status
[21:45:48.687] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:48.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:77:0) after 1m0s
[21:46:48.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:77:0)
[21:46:48.719] Timer tick, asking Buildbucket for the build status
[21:46:50.538] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:50.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:78:0) after 1m0s
[21:47:50.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:78:0)
[21:47:50.567] Timer tick, asking Buildbucket for the build status
[21:47:51.493] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:51.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:79:0) after 1m0s
[21:48:51.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:79:0)
[21:48:51.520] Timer tick, asking Buildbucket for the build status
[21:48:53.366] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:53.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:80:0) after 1m0s
[21:49:53.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:80:0)
[21:49:53.439] Timer tick, asking Buildbucket for the build status
[21:49:54.090] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:54.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:81:0) after 1m0s
[21:50:54.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:81:0)
[21:50:54.124] Timer tick, asking Buildbucket for the build status
[21:50:54.647] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:54.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:82:0) after 1m0s
[21:51:54.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:82:0)
[21:51:54.738] Timer tick, asking Buildbucket for the build status
[21:51:54.958] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:54.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:83:0) after 1m0s
[21:52:55.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:83:0)
[21:52:55.085] Timer tick, asking Buildbucket for the build status
[21:52:56.718] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:56.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:84:0) after 1m0s
[21:53:56.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:84:0)
[21:53:56.755] Timer tick, asking Buildbucket for the build status
[21:53:57.664] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:57.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:85:0) after 1m0s
[21:54:57.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:85:0)
[21:54:57.729] Timer tick, asking Buildbucket for the build status
[21:54:58.288] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:58.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:86:0) after 1m0s
[21:55:58.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:86:0)
[21:55:58.351] Timer tick, asking Buildbucket for the build status
[21:55:58.679] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:58.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:87:0) after 1m0s
[21:56:58.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:87:0)
[21:56:58.726] Timer tick, asking Buildbucket for the build status
[21:57:01.208] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:01.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:88:0) after 1m0s
[21:58:01.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:88:0)
[21:58:01.387] Timer tick, asking Buildbucket for the build status
[21:58:02.121] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:02.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:89:0) after 1m0s
[21:59:02.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:89:0)
[21:59:02.115] Timer tick, asking Buildbucket for the build status
[21:59:02.600] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:02.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:90:0) after 1m0s
[22:00:02.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:90:0)
[22:00:02.652] Timer tick, asking Buildbucket for the build status
[22:00:04.044] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:04.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:91:0) after 1m0s
[22:01:04.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:91:0)
[22:01:04.211] Timer tick, asking Buildbucket for the build status
[22:01:05.320] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:05.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:92:0) after 1m0s
[22:02:05.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:92:0)
[22:02:05.437] Timer tick, asking Buildbucket for the build status
[22:02:06.145] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:06.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:93:0) after 1m0s
[22:03:06.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:93:0)
[22:03:06.153] Timer tick, asking Buildbucket for the build status
[22:03:06.456] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:06.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:94:0) after 1m0s
[22:04:06.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:94:0)
[22:04:06.462] Timer tick, asking Buildbucket for the build status
[22:04:07.082] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:07.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:95:0) after 1m0s
[22:05:07.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:95:0)
[22:05:07.150] Timer tick, asking Buildbucket for the build status
[22:05:09.664] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:09.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:96:0) after 1m0s
[22:06:09.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:96:0)
[22:06:09.707] Timer tick, asking Buildbucket for the build status
[22:06:10.407] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:10.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:97:0) after 1m0s
[22:07:10.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:97:0)
[22:07:10.479] Timer tick, asking Buildbucket for the build status
[22:07:10.772] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:10.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:98:0) after 1m0s
[22:08:10.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:98:0)
[22:08:10.769] Timer tick, asking Buildbucket for the build status
[22:08:11.425] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:11.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:99:0) after 1m0s
[22:09:11.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:99:0)
[22:09:11.502] Timer tick, asking Buildbucket for the build status
[22:09:12.008] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:12.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:100:0) after 1m0s
[22:10:12.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:100:0)
[22:10:12.170] Timer tick, asking Buildbucket for the build status
[22:10:12.503] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:12.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:101:0) after 1m0s
[22:11:12.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:101:0)
[22:11:12.585] Timer tick, asking Buildbucket for the build status
[22:11:12.847] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:12.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:102:0) after 1m0s
[22:12:12.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:102:0)
[22:12:12.912] Timer tick, asking Buildbucket for the build status
[22:12:13.800] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:13.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:103:0) after 1m0s
[22:13:13.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:103:0)
[22:13:13.843] Timer tick, asking Buildbucket for the build status
[22:13:16.746] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:16.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:104:0) after 1m0s
[22:14:16.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:104:0)
[22:14:16.791] Timer tick, asking Buildbucket for the build status
[22:14:17.014] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:17.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:105:0) after 1m0s
[22:15:17.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:105:0)
[22:15:17.047] Timer tick, asking Buildbucket for the build status
[22:15:17.826] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:17.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:106:0) after 1m0s
[22:16:17.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:106:0)
[22:16:17.892] Timer tick, asking Buildbucket for the build status
[22:16:18.087] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:18.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:107:0) after 1m0s
[22:17:18.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:107:0)
[22:17:18.174] Timer tick, asking Buildbucket for the build status
[22:17:20.211] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:20.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:108:0) after 1m0s
[22:18:20.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:108:0)
[22:18:20.253] Timer tick, asking Buildbucket for the build status
[22:18:20.580] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:20.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:109:0) after 1m0s
[22:19:20.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:109:0)
[22:19:20.739] Timer tick, asking Buildbucket for the build status
[22:19:21.472] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:21.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:110:0) after 1m0s
[22:20:21.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:110:0)
[22:20:21.512] Timer tick, asking Buildbucket for the build status
[22:20:23.906] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:23.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:111:0) after 1m0s
[22:21:23.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:111:0)
[22:21:23.987] Timer tick, asking Buildbucket for the build status
[22:21:28.296] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:28.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:112:0) after 1m0s
[22:22:28.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:112:0)
[22:22:28.363] Timer tick, asking Buildbucket for the build status
[22:22:29.360] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:29.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:113:0) after 1m0s
[22:23:29.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:113:0)
[22:23:29.516] Timer tick, asking Buildbucket for the build status
[22:23:29.727] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:114:0) after 1m0s
[22:24:29.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:114:0)
[22:24:29.774] Timer tick, asking Buildbucket for the build status
[22:24:32.206] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:32.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:115:0) after 1m0s
[22:25:32.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:115:0)
[22:25:32.377] Timer tick, asking Buildbucket for the build status
[22:25:35.452] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:35.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:116:0) after 1m0s
[22:26:36.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:116:0)
[22:26:36.036] Timer tick, asking Buildbucket for the build status
[22:26:36.471] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:36.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:117:0) after 1m0s
[22:27:36.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:117:0)
[22:27:36.627] Timer tick, asking Buildbucket for the build status
[22:27:37.179] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:37.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:118:0) after 1m0s
[22:28:37.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:118:0)
[22:28:37.336] Timer tick, asking Buildbucket for the build status
[22:28:39.208] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:39.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:119:0) after 1m0s
[22:29:39.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:119:0)
[22:29:39.364] Timer tick, asking Buildbucket for the build status
[22:29:44.441] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:44.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:120:0) after 1m0s
[22:30:44.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:120:0)
[22:30:44.511] Timer tick, asking Buildbucket for the build status
[22:30:45.199] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:45.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:121:0) after 1m0s
[22:31:45.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:121:0)
[22:31:45.225] Timer tick, asking Buildbucket for the build status
[22:31:47.574] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:47.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:122:0) after 1m0s
[22:32:47.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:122:0)
[22:32:47.714] Timer tick, asking Buildbucket for the build status
[22:32:49.614] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:49.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:123:0) after 1m0s
[22:33:49.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:123:0)
[22:33:49.646] Timer tick, asking Buildbucket for the build status
[22:33:50.108] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:50.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:124:0) after 1m0s
[22:34:50.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:124:0)
[22:34:50.268] Timer tick, asking Buildbucket for the build status
[22:34:50.784] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:50.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:125:0) after 1m0s
[22:35:51.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:125:0)
[22:35:51.093] Timer tick, asking Buildbucket for the build status
[22:35:51.397] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:51.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:126:0) after 1m0s
[22:36:51.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:126:0)
[22:36:51.772] Timer tick, asking Buildbucket for the build status
[22:36:51.959] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:51.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:127:0) after 1m0s
[22:37:52.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:127:0)
[22:37:52.321] Timer tick, asking Buildbucket for the build status
[22:37:52.538] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:52.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:128:0) after 1m0s
[22:38:52.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:128:0)
[22:38:52.670] Timer tick, asking Buildbucket for the build status
[22:38:53.075] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:53.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:129:0) after 1m0s
[22:39:53.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:129:0)
[22:39:53.141] Timer tick, asking Buildbucket for the build status
[22:39:53.605] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:53.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:130:0) after 1m0s
[22:40:53.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:130:0)
[22:40:53.963] Timer tick, asking Buildbucket for the build status
[22:40:54.633] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:54.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:131:0) after 1m0s
[22:41:54.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:131:0)
[22:41:54.660] Timer tick, asking Buildbucket for the build status
[22:41:56.297] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:56.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:132:0) after 1m0s
[22:42:56.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:132:0)
[22:42:56.328] Timer tick, asking Buildbucket for the build status
[22:42:56.720] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:56.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:133:0) after 1m0s
[22:43:56.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:133:0)
[22:43:56.841] Timer tick, asking Buildbucket for the build status
[22:43:57.584] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:57.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:134:0) after 1m0s
[22:44:57.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:134:0)
[22:44:57.696] Timer tick, asking Buildbucket for the build status
[22:44:58.333] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:58.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:135:0) after 1m0s
[22:45:58.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:135:0)
[22:45:58.433] Timer tick, asking Buildbucket for the build status
[22:45:59.766] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:59.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:136:0) after 1m0s
[22:46:59.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:136:0)
[22:46:59.875] Timer tick, asking Buildbucket for the build status
[22:47:00.401] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:00.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:137:0) after 1m0s
[22:48:00.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:137:0)
[22:48:00.498] Timer tick, asking Buildbucket for the build status
[22:48:00.928] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:00.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:138:0) after 1m0s
[22:49:01.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:138:0)
[22:49:01.139] Timer tick, asking Buildbucket for the build status
[22:49:02.405] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:02.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:139:0) after 1m0s
[22:50:02.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:139:0)
[22:50:02.613] Timer tick, asking Buildbucket for the build status
[22:50:02.779] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:02.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:140:0) after 1m0s
[22:51:03.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:140:0)
[22:51:03.105] Timer tick, asking Buildbucket for the build status
[22:51:03.488] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:03.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:141:0) after 1m0s
[22:52:03.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:141:0)
[22:52:03.540] Timer tick, asking Buildbucket for the build status
[22:52:06.117] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:06.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:142:0) after 1m0s
[22:53:06.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:142:0)
[22:53:06.153] Timer tick, asking Buildbucket for the build status
[22:53:07.494] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:07.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:143:0) after 1m0s
[22:54:07.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:143:0)
[22:54:07.565] Timer tick, asking Buildbucket for the build status
[22:54:07.800] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:07.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:144:0) after 1m0s
[22:55:07.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:144:0)
[22:55:07.922] Timer tick, asking Buildbucket for the build status
[22:55:08.250] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:08.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:145:0) after 1m0s
[22:56:08.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:145:0)
[22:56:08.306] Timer tick, asking Buildbucket for the build status
[22:56:08.468] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:08.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:146:0) after 1m0s
[22:57:08.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:146:0)
[22:57:08.649] Timer tick, asking Buildbucket for the build status
[22:57:09.376] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:09.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:147:0) after 1m0s
[22:58:09.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:147:0)
[22:58:09.376] Timer tick, asking Buildbucket for the build status
[22:58:10.475] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:10.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:148:0) after 1m0s
[22:59:10.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:148:0)
[22:59:10.887] Timer tick, asking Buildbucket for the build status
[22:59:12.413] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:12.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:149:0) after 1m0s
[23:00:12.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:149:0)
[23:00:12.504] Timer tick, asking Buildbucket for the build status
[23:00:12.717] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:12.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:150:0) after 1m0s
[23:01:12.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:150:0)
[23:01:12.909] Timer tick, asking Buildbucket for the build status
[23:01:13.319] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:13.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:151:0) after 1m0s
[23:02:13.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:151:0)
[23:02:13.397] Timer tick, asking Buildbucket for the build status
[23:02:13.892] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:13.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:152:0) after 1m0s
[23:03:14.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:152:0)
[23:03:14.092] Timer tick, asking Buildbucket for the build status
[23:03:14.790] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:14.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:153:0) after 1m0s
[23:04:14.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:153:0)
[23:04:14.849] Timer tick, asking Buildbucket for the build status
[23:04:15.069] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:15.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:154:0) after 1m0s
[23:05:15.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:154:0)
[23:05:15.292] Timer tick, asking Buildbucket for the build status
[23:05:16.669] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:16.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:155:0) after 1m0s
[23:06:16.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:155:0)
[23:06:16.745] Timer tick, asking Buildbucket for the build status
[23:06:17.613] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:17.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:156:0) after 1m0s
[23:07:17.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:156:0)
[23:07:17.904] Timer tick, asking Buildbucket for the build status
[23:07:18.074] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:18.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:157:0) after 1m0s
[23:08:18.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:157:0)
[23:08:18.263] Timer tick, asking Buildbucket for the build status
[23:08:18.626] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:18.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:158:0) after 1m0s
[23:09:18.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:158:0)
[23:09:18.742] Timer tick, asking Buildbucket for the build status
[23:09:19.059] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:19.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:159:0) after 1m0s
[23:10:19.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:159:0)
[23:10:19.118] Timer tick, asking Buildbucket for the build status
[23:10:19.512] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:160:0) after 1m0s
[23:11:19.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:160:0)
[23:11:19.567] Timer tick, asking Buildbucket for the build status
[23:11:19.844] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:19.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:161:0) after 1m0s
[23:12:19.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:161:0)
[23:12:19.945] Timer tick, asking Buildbucket for the build status
[23:12:20.081] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:20.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:162:0) after 1m0s
[23:13:20.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:162:0)
[23:13:20.136] Timer tick, asking Buildbucket for the build status
[23:13:23.762] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:23.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:163:0) after 1m0s
[23:14:23.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:163:0)
[23:14:23.816] Timer tick, asking Buildbucket for the build status
[23:14:24.927] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:24.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:164:0) after 1m0s
[23:15:25.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:164:0)
[23:15:25.028] Timer tick, asking Buildbucket for the build status
[23:15:25.609] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:25.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:165:0) after 1m0s
[23:16:25.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:165:0)
[23:16:25.710] Timer tick, asking Buildbucket for the build status
[23:16:26.105] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:26.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:166:0) after 1m0s
[23:17:26.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:166:0)
[23:17:26.156] Timer tick, asking Buildbucket for the build status
[23:17:26.953] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:26.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:167:0) after 1m0s
[23:18:27.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:167:0)
[23:18:27.082] Timer tick, asking Buildbucket for the build status
[23:18:27.323] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:27.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:168:0) after 1m0s
[23:19:27.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:168:0)
[23:19:27.419] Timer tick, asking Buildbucket for the build status
[23:19:28.285] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:28.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:169:0) after 1m0s
[23:20:28.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:169:0)
[23:20:28.303] Timer tick, asking Buildbucket for the build status
[23:20:29.284] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:29.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:170:0) after 1m0s
[23:21:29.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:170:0)
[23:21:29.378] Timer tick, asking Buildbucket for the build status
[23:21:29.850] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:29.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:171:0) after 1m0s
[23:22:29.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:171:0)
[23:22:29.891] Timer tick, asking Buildbucket for the build status
[23:22:30.607] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:30.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:172:0) after 1m0s
[23:23:30.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:172:0)
[23:23:30.639] Timer tick, asking Buildbucket for the build status
[23:23:31.259] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:31.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:173:0) after 1m0s
[23:24:31.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:173:0)
[23:24:31.422] Timer tick, asking Buildbucket for the build status
[23:24:31.674] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:31.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:174:0) after 1m0s
[23:25:31.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:174:0)
[23:25:31.794] Timer tick, asking Buildbucket for the build status
[23:25:32.293] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:32.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:175:0) after 1m0s
[23:26:32.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:175:0)
[23:26:32.375] Timer tick, asking Buildbucket for the build status
[23:26:33.260] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:33.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:176:0) after 1m0s
[23:27:33.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:176:0)
[23:27:33.285] Timer tick, asking Buildbucket for the build status
[23:27:33.519] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:33.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:177:0) after 1m0s
[23:28:33.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:177:0)
[23:28:33.648] Timer tick, asking Buildbucket for the build status
[23:28:34.332] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:34.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:178:0) after 1m0s
[23:29:34.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:178:0)
[23:29:34.498] Timer tick, asking Buildbucket for the build status
[23:29:35.097] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:35.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:179:0) after 1m0s
[23:30:35.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:179:0)
[23:30:35.213] Timer tick, asking Buildbucket for the build status
[23:30:35.730] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:35.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:180:0) after 1m0s
[23:31:35.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:180:0)
[23:31:35.856] Timer tick, asking Buildbucket for the build status
[23:31:36.345] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:36.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:181:0) after 1m0s
[23:32:36.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:181:0)
[23:32:36.484] Timer tick, asking Buildbucket for the build status
[23:32:36.677] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:36.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:182:0) after 1m0s
[23:33:36.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:182:0)
[23:33:36.756] Timer tick, asking Buildbucket for the build status
[23:33:38.226] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:38.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:183:0) after 1m0s
[23:34:38.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:183:0)
[23:34:38.305] Timer tick, asking Buildbucket for the build status
[23:34:38.828] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:38.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:184:0) after 1m0s
[23:35:38.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:184:0)
[23:35:38.834] Timer tick, asking Buildbucket for the build status
[23:35:41.019] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:41.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:185:0) after 1m0s
[23:36:41.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:185:0)
[23:36:41.149] Timer tick, asking Buildbucket for the build status
[23:36:41.480] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:41.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:186:0) after 1m0s
[23:37:41.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:186:0)
[23:37:41.541] Timer tick, asking Buildbucket for the build status
[23:37:43.465] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:43.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:187:0) after 1m0s
[23:38:43.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:187:0)
[23:38:43.500] Timer tick, asking Buildbucket for the build status
[23:38:43.999] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:43.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:188:0) after 1m0s
[23:39:44.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:188:0)
[23:39:44.085] Timer tick, asking Buildbucket for the build status
[23:39:44.853] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:44.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:189:0) after 1m0s
[23:40:44.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:189:0)
[23:40:44.858] Timer tick, asking Buildbucket for the build status
[23:40:45.038] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:45.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:190:0) after 1m0s
[23:41:45.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:190:0)
[23:41:45.110] Timer tick, asking Buildbucket for the build status
[23:41:45.976] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:45.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:191:0) after 1m0s
[23:42:46.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:191:0)
[23:42:46.064] Timer tick, asking Buildbucket for the build status
[23:42:46.301] Build 8904030917091128928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:46.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069460979556437376:192:0) after 1m0s
[23:43:11.567] Received PubSub notification, asking Buildbucket for the build status
[23:43:11.736] Build 8904030917091128928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:43:11.736] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566862989961800",
"created_by": "project:chromium",
"created_ts": "1566851424091966",
"id": "8904030917091128928",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f\"}}",
"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-bzrg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14547, \"got_angle_revision\": \"87b106a0944e5bc83bbee8de95a49c4be3de3825\", \"got_dawn_revision\": \"f19c328b5ba5fb3aaf02e50b5fc11dab93b098b7\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f\", \"got_revision_cp\": \"refs/heads/master@{#690484}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"2334bc12561ce4921dad83678b344df2abf1c775\", \"got_v8_revision_cp\": \"refs/heads/7.8.196@{#1}\", \"got_webrtc_revision\": \"4869bd6309bbe2e9e038451e9549f5a9d12e4a38\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28957}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f\"}, \"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-bzrg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4397-8786906\"], \"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": "1566851546746825",
"status": "COMPLETED",
"status_changed_ts": "1566862990301235",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14547",
"builder:Windows deterministic",
"buildset:commit/git/9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f3b8ef10ffcb5c92111a4ae596260f1a1afb73f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069460979556437376",
"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/8904030917091128928/+/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:46e870edecb84510",
"user_agent:luci-scheduler"
],
"updated_ts": "1566862990305071",
"url": "https://ci.chromium.org/b/8904030917091128928",
"utcnow_ts": "1566862991725714"
}
}
[23:43:11.736] Invocation finished in 3h12m49.379965958s with status SUCCEEDED