[00:46:30.999] New invocation is queued and will start shortly
[00:46:32.644] Starting the invocation (attempt 1)
[00:46:32.696] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:46:32.696] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:46:32.696] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9067814118990204624",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"6cced4da95c416dd95dca80040a641b935492f0a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9067814118990204624",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/6cced4da95c416dd95dca80040a641b935492f0a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6cced4da95c416dd95dca80040a641b935492f0a",
"gitiles_ref:refs/heads/master"
]
}
[00:46:35.939] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568421993782877",
"id": "8902384055406237936",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6cced4da95c416dd95dca80040a641b935492f0a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568421995328073",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14711",
"builder:Windows deterministic",
"buildset:commit/git/6cced4da95c416dd95dca80040a641b935492f0a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6cced4da95c416dd95dca80040a641b935492f0a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067814118990204624",
"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/8902384055406237936/+/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": "1568421995332558",
"url": "https://ci.chromium.org/b/8902384055406237936",
"utcnow_ts": "1568421995904174"
}
}
[00:46:35.939] Task URL: https://ci.chromium.org/b/8902384055406237936
[00:46:35.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:2:0) after 1m0s
[00:47:36.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:2:0)
[00:47:36.000] Timer tick, asking Buildbucket for the build status
[00:47:40.855] Build 8902384055406237936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:40.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:3:0) after 1m0s
[00:48:30.284] Received PubSub notification, asking Buildbucket for the build status
[00:48:30.463] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:41.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:3:0)
[00:48:41.010] Timer tick, asking Buildbucket for the build status
[00:48:42.416] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:42.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:5:0) after 1m0s
[00:49:42.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:5:0)
[00:49:42.412] Timer tick, asking Buildbucket for the build status
[00:49:46.235] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:46.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:6:0) after 1m0s
[00:50:46.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:6:0)
[00:50:46.811] Timer tick, asking Buildbucket for the build status
[00:50:46.991] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:46.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:7:0) after 1m0s
[00:51:47.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:7:0)
[00:51:47.183] Timer tick, asking Buildbucket for the build status
[00:51:48.020] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:48.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:8:0) after 1m0s
[00:52:48.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:8:0)
[00:52:48.155] Timer tick, asking Buildbucket for the build status
[00:52:48.335] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:48.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:9:0) after 1m0s
[00:53:48.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:9:0)
[00:53:48.334] Timer tick, asking Buildbucket for the build status
[00:53:48.746] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:48.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:10:0) after 1m0s
[00:54:48.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:10:0)
[00:54:48.984] Timer tick, asking Buildbucket for the build status
[00:54:49.472] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:49.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:11:0) after 1m0s
[00:55:49.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:11:0)
[00:55:49.485] Timer tick, asking Buildbucket for the build status
[00:55:49.818] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:49.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:12:0) after 1m0s
[00:56:50.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:12:0)
[00:56:50.048] Timer tick, asking Buildbucket for the build status
[00:56:52.723] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:52.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:13:0) after 1m0s
[00:57:52.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:13:0)
[00:57:52.869] Timer tick, asking Buildbucket for the build status
[00:57:53.472] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:53.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:14:0) after 1m0s
[00:58:53.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:14:0)
[00:58:53.574] Timer tick, asking Buildbucket for the build status
[00:58:53.953] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:53.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:15:0) after 1m0s
[00:59:53.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:15:0)
[00:59:53.975] Timer tick, asking Buildbucket for the build status
[00:59:55.679] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:55.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:16:0) after 1m0s
[01:00:55.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:16:0)
[01:00:55.892] Timer tick, asking Buildbucket for the build status
[01:00:56.893] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:17:0) after 1m0s
[01:01:56.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:17:0)
[01:01:56.967] Timer tick, asking Buildbucket for the build status
[01:01:57.841] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:57.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:18:0) after 1m0s
[01:02:58.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:18:0)
[01:02:58.120] Timer tick, asking Buildbucket for the build status
[01:03:00.405] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:00.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:19:0) after 1m0s
[01:04:00.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:19:0)
[01:04:00.526] Timer tick, asking Buildbucket for the build status
[01:04:01.055] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:01.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:20:0) after 1m0s
[01:05:01.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:20:0)
[01:05:01.169] Timer tick, asking Buildbucket for the build status
[01:05:01.822] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:01.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:21:0) after 1m0s
[01:06:01.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:21:0)
[01:06:01.871] Timer tick, asking Buildbucket for the build status
[01:06:02.701] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:02.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:22:0) after 1m0s
[01:07:02.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:22:0)
[01:07:02.818] Timer tick, asking Buildbucket for the build status
[01:07:08.059] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:08.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:23:0) after 1m0s
[01:08:08.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:23:0)
[01:08:08.293] Timer tick, asking Buildbucket for the build status
[01:08:09.866] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:09.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:24:0) after 1m0s
[01:09:09.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:24:0)
[01:09:09.914] Timer tick, asking Buildbucket for the build status
[01:09:10.126] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:10.126] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:25:0) after 1m0s
[01:10:10.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:25:0)
[01:10:10.176] Timer tick, asking Buildbucket for the build status
[01:10:10.839] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:10.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:26:0) after 1m0s
[01:11:10.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:26:0)
[01:11:10.952] Timer tick, asking Buildbucket for the build status
[01:11:12.004] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:12.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:27:0) after 1m0s
[01:12:12.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:27:0)
[01:12:12.113] Timer tick, asking Buildbucket for the build status
[01:12:12.407] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:12.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:28:0) after 1m0s
[01:13:12.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:28:0)
[01:13:12.526] Timer tick, asking Buildbucket for the build status
[01:13:15.195] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:15.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:29:0) after 1m0s
[01:14:15.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:29:0)
[01:14:15.317] Timer tick, asking Buildbucket for the build status
[01:14:18.701] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:30:0) after 1m0s
[01:15:18.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:30:0)
[01:15:18.807] Timer tick, asking Buildbucket for the build status
[01:15:21.600] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:21.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:31:0) after 1m0s
[01:16:21.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:31:0)
[01:16:21.624] Timer tick, asking Buildbucket for the build status
[01:16:25.723] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:25.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:32:0) after 1m0s
[01:17:25.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:32:0)
[01:17:25.809] Timer tick, asking Buildbucket for the build status
[01:17:29.842] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:29.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:33:0) after 1m0s
[01:18:29.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:33:0)
[01:18:29.934] Timer tick, asking Buildbucket for the build status
[01:18:30.568] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:30.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:34:0) after 1m0s
[01:19:30.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:34:0)
[01:19:30.620] Timer tick, asking Buildbucket for the build status
[01:19:32.130] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:32.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:35:0) after 1m0s
[01:20:32.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:35:0)
[01:20:32.215] Timer tick, asking Buildbucket for the build status
[01:20:34.997] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:34.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:36:0) after 1m0s
[01:21:35.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:36:0)
[01:21:35.105] Timer tick, asking Buildbucket for the build status
[01:21:36.138] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:36.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:37:0) after 1m0s
[01:22:36.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:37:0)
[01:22:36.240] Timer tick, asking Buildbucket for the build status
[01:22:36.535] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:36.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:38:0) after 1m0s
[01:23:36.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:38:0)
[01:23:36.688] Timer tick, asking Buildbucket for the build status
[01:23:38.043] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:38.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:39:0) after 1m0s
[01:24:38.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:39:0)
[01:24:38.203] Timer tick, asking Buildbucket for the build status
[01:24:39.028] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:39.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:40:0) after 1m0s
[01:25:39.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:40:0)
[01:25:39.173] Timer tick, asking Buildbucket for the build status
[01:25:41.085] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:41.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:41:0) after 1m0s
[01:26:41.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:41:0)
[01:26:41.153] Timer tick, asking Buildbucket for the build status
[01:26:42.694] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:42.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:42:0) after 1m0s
[01:27:42.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:42:0)
[01:27:42.747] Timer tick, asking Buildbucket for the build status
[01:27:46.057] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:46.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:43:0) after 1m0s
[01:28:46.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:43:0)
[01:28:46.195] Timer tick, asking Buildbucket for the build status
[01:28:47.098] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:47.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:44:0) after 1m0s
[01:29:47.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:44:0)
[01:29:47.208] Timer tick, asking Buildbucket for the build status
[01:29:48.350] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:48.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:45:0) after 1m0s
[01:30:48.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:45:0)
[01:30:48.415] Timer tick, asking Buildbucket for the build status
[01:30:49.386] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:49.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:46:0) after 1m0s
[01:31:49.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:46:0)
[01:31:49.418] Timer tick, asking Buildbucket for the build status
[01:31:53.395] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:53.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:47:0) after 1m0s
[01:32:53.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:47:0)
[01:32:53.584] Timer tick, asking Buildbucket for the build status
[01:32:57.482] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:57.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:48:0) after 1m0s
[01:33:57.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:48:0)
[01:33:57.546] Timer tick, asking Buildbucket for the build status
[01:34:00.640] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:49:0) after 1m0s
[01:35:00.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:49:0)
[01:35:00.716] Timer tick, asking Buildbucket for the build status
[01:35:01.425] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:01.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:50:0) after 1m0s
[01:36:01.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:50:0)
[01:36:01.483] Timer tick, asking Buildbucket for the build status
[01:36:06.654] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:06.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:51:0) after 1m0s
[01:37:06.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:51:0)
[01:37:06.669] Timer tick, asking Buildbucket for the build status
[01:37:06.871] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:06.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:52:0) after 1m0s
[01:38:06.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:52:0)
[01:38:06.906] Timer tick, asking Buildbucket for the build status
[01:38:11.045] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:11.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:53:0) after 1m0s
[01:39:11.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:53:0)
[01:39:11.145] Timer tick, asking Buildbucket for the build status
[01:39:11.611] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:11.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:54:0) after 1m0s
[01:40:11.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:54:0)
[01:40:11.744] Timer tick, asking Buildbucket for the build status
[01:40:12.918] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:12.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:55:0) after 1m0s
[01:41:12.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:55:0)
[01:41:12.960] Timer tick, asking Buildbucket for the build status
[01:41:13.437] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:56:0) after 1m0s
[01:42:13.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:56:0)
[01:42:13.478] Timer tick, asking Buildbucket for the build status
[01:42:13.840] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:13.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:57:0) after 1m0s
[01:43:13.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:57:0)
[01:43:13.867] Timer tick, asking Buildbucket for the build status
[01:43:14.654] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:14.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:58:0) after 1m0s
[01:44:14.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:58:0)
[01:44:14.721] Timer tick, asking Buildbucket for the build status
[01:44:15.189] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:15.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:59:0) after 1m0s
[01:45:15.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:59:0)
[01:45:15.244] Timer tick, asking Buildbucket for the build status
[01:45:15.386] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:60:0) after 1m0s
[01:46:15.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:60:0)
[01:46:15.429] Timer tick, asking Buildbucket for the build status
[01:46:16.747] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:16.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:61:0) after 1m0s
[01:47:16.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:61:0)
[01:47:16.820] Timer tick, asking Buildbucket for the build status
[01:47:17.231] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:17.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:62:0) after 1m0s
[01:48:17.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:62:0)
[01:48:17.247] Timer tick, asking Buildbucket for the build status
[01:48:17.569] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:17.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:63:0) after 1m0s
[01:49:17.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:63:0)
[01:49:17.590] Timer tick, asking Buildbucket for the build status
[01:49:18.890] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:18.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:64:0) after 1m0s
[01:50:18.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:64:0)
[01:50:18.956] Timer tick, asking Buildbucket for the build status
[01:50:19.721] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:19.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:65:0) after 1m0s
[01:51:19.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:65:0)
[01:51:19.752] Timer tick, asking Buildbucket for the build status
[01:51:20.727] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:20.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:66:0) after 1m0s
[01:52:20.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:66:0)
[01:52:20.776] Timer tick, asking Buildbucket for the build status
[01:52:26.379] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:26.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:67:0) after 1m0s
[01:53:26.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:67:0)
[01:53:26.426] Timer tick, asking Buildbucket for the build status
[01:53:26.647] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:26.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:68:0) after 1m0s
[01:54:26.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:68:0)
[01:54:26.733] Timer tick, asking Buildbucket for the build status
[01:54:30.257] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:30.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:69:0) after 1m0s
[01:55:30.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:69:0)
[01:55:30.348] Timer tick, asking Buildbucket for the build status
[01:55:30.732] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:30.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:70:0) after 1m0s
[01:56:30.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:70:0)
[01:56:30.910] Timer tick, asking Buildbucket for the build status
[01:56:31.335] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:31.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:71:0) after 1m0s
[01:57:31.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:71:0)
[01:57:31.916] Timer tick, asking Buildbucket for the build status
[01:57:32.343] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:32.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:72:0) after 1m0s
[01:58:32.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:72:0)
[01:58:32.422] Timer tick, asking Buildbucket for the build status
[01:58:33.104] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:33.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:73:0) after 1m0s
[01:59:33.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:73:0)
[01:59:33.185] Timer tick, asking Buildbucket for the build status
[01:59:33.499] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:33.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:74:0) after 1m0s
[02:00:33.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:74:0)
[02:00:33.614] Timer tick, asking Buildbucket for the build status
[02:00:36.634] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:36.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:75:0) after 1m0s
[02:01:36.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:75:0)
[02:01:36.956] Timer tick, asking Buildbucket for the build status
[02:01:37.112] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:37.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:76:0) after 1m0s
[02:02:37.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:76:0)
[02:02:37.199] Timer tick, asking Buildbucket for the build status
[02:02:37.752] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:37.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:77:0) after 1m0s
[02:03:37.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:77:0)
[02:03:37.820] Timer tick, asking Buildbucket for the build status
[02:03:38.275] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:38.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:78:0) after 1m0s
[02:04:38.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:78:0)
[02:04:38.353] Timer tick, asking Buildbucket for the build status
[02:04:38.654] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:79:0) after 1m0s
[02:05:38.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:79:0)
[02:05:38.684] Timer tick, asking Buildbucket for the build status
[02:05:39.495] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:39.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:80:0) after 1m0s
[02:06:39.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:80:0)
[02:06:39.636] Timer tick, asking Buildbucket for the build status
[02:06:40.008] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:40.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:81:0) after 1m0s
[02:07:40.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:81:0)
[02:07:40.082] Timer tick, asking Buildbucket for the build status
[02:07:40.569] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:40.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:82:0) after 1m0s
[02:08:40.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:82:0)
[02:08:40.619] Timer tick, asking Buildbucket for the build status
[02:08:40.800] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:40.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:83:0) after 1m0s
[02:09:40.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:83:0)
[02:09:40.823] Timer tick, asking Buildbucket for the build status
[02:09:41.063] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:41.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:84:0) after 1m0s
[02:10:41.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:84:0)
[02:10:41.134] Timer tick, asking Buildbucket for the build status
[02:10:41.539] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:41.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:85:0) after 1m0s
[02:11:41.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:85:0)
[02:11:41.586] Timer tick, asking Buildbucket for the build status
[02:11:41.789] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:41.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:86:0) after 1m0s
[02:12:41.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:86:0)
[02:12:41.804] Timer tick, asking Buildbucket for the build status
[02:12:42.608] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:42.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:87:0) after 1m0s
[02:13:42.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:87:0)
[02:13:42.629] Timer tick, asking Buildbucket for the build status
[02:13:42.861] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:42.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:88:0) after 1m0s
[02:14:42.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:88:0)
[02:14:42.890] Timer tick, asking Buildbucket for the build status
[02:14:43.032] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:43.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:89:0) after 1m0s
[02:15:43.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:89:0)
[02:15:43.011] Timer tick, asking Buildbucket for the build status
[02:15:43.824] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:43.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:90:0) after 1m0s
[02:16:43.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:90:0)
[02:16:43.847] Timer tick, asking Buildbucket for the build status
[02:16:43.987] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:43.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:91:0) after 1m0s
[02:17:44.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:91:0)
[02:17:44.085] Timer tick, asking Buildbucket for the build status
[02:17:48.164] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:92:0) after 1m0s
[02:18:48.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:92:0)
[02:18:48.194] Timer tick, asking Buildbucket for the build status
[02:18:48.719] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:48.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:93:0) after 1m0s
[02:19:48.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:93:0)
[02:19:48.771] Timer tick, asking Buildbucket for the build status
[02:19:48.960] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:48.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:94:0) after 1m0s
[02:20:48.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:94:0)
[02:20:48.964] Timer tick, asking Buildbucket for the build status
[02:20:49.762] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:49.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:95:0) after 1m0s
[02:21:49.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:95:0)
[02:21:49.801] Timer tick, asking Buildbucket for the build status
[02:21:50.175] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:50.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:96:0) after 1m0s
[02:22:50.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:96:0)
[02:22:50.171] Timer tick, asking Buildbucket for the build status
[02:22:50.544] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:50.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:97:0) after 1m0s
[02:23:50.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:97:0)
[02:23:50.618] Timer tick, asking Buildbucket for the build status
[02:23:50.947] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:50.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:98:0) after 1m0s
[02:24:50.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:98:0)
[02:24:50.965] Timer tick, asking Buildbucket for the build status
[02:24:51.274] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:51.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:99:0) after 1m0s
[02:25:51.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:99:0)
[02:25:51.319] Timer tick, asking Buildbucket for the build status
[02:25:52.163] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:52.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:100:0) after 1m0s
[02:26:52.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:100:0)
[02:26:52.292] Timer tick, asking Buildbucket for the build status
[02:26:52.411] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:52.412] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:101:0) after 1m0s
[02:27:52.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:101:0)
[02:27:52.784] Timer tick, asking Buildbucket for the build status
[02:27:53.403] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:53.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:102:0) after 1m0s
[02:28:53.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:102:0)
[02:28:53.703] Timer tick, asking Buildbucket for the build status
[02:28:54.570] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:103:0) after 1m0s
[02:29:54.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:103:0)
[02:29:54.874] Timer tick, asking Buildbucket for the build status
[02:29:55.092] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:55.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:104:0) after 1m0s
[02:30:55.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:104:0)
[02:30:55.286] Timer tick, asking Buildbucket for the build status
[02:31:00.460] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:00.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:105:0) after 1m0s
[02:32:00.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:105:0)
[02:32:00.958] Timer tick, asking Buildbucket for the build status
[02:32:01.956] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:01.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:106:0) after 1m0s
[02:33:02.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:106:0)
[02:33:02.126] Timer tick, asking Buildbucket for the build status
[02:33:02.296] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:02.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:107:0) after 1m0s
[02:34:02.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:107:0)
[02:34:02.503] Timer tick, asking Buildbucket for the build status
[02:34:02.856] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:02.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:108:0) after 1m0s
[02:35:03.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:108:0)
[02:35:03.112] Timer tick, asking Buildbucket for the build status
[02:35:03.772] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:03.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:109:0) after 1m0s
[02:36:03.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:109:0)
[02:36:03.942] Timer tick, asking Buildbucket for the build status
[02:36:04.316] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:04.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:110:0) after 1m0s
[02:37:04.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:110:0)
[02:37:04.448] Timer tick, asking Buildbucket for the build status
[02:37:04.936] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:04.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:111:0) after 1m0s
[02:38:05.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:111:0)
[02:38:05.191] Timer tick, asking Buildbucket for the build status
[02:38:05.529] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:05.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:112:0) after 1m0s
[02:39:05.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:112:0)
[02:39:05.608] Timer tick, asking Buildbucket for the build status
[02:39:06.686] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:06.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:113:0) after 1m0s
[02:40:06.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:113:0)
[02:40:06.831] Timer tick, asking Buildbucket for the build status
[02:40:07.395] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:07.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:114:0) after 1m0s
[02:41:07.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:114:0)
[02:41:07.440] Timer tick, asking Buildbucket for the build status
[02:41:13.860] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:13.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:115:0) after 1m0s
[02:42:13.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:115:0)
[02:42:13.876] Timer tick, asking Buildbucket for the build status
[02:42:14.054] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:14.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:116:0) after 1m0s
[02:43:14.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:116:0)
[02:43:14.048] Timer tick, asking Buildbucket for the build status
[02:43:14.882] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:14.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:117:0) after 1m0s
[02:44:14.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:117:0)
[02:44:14.949] Timer tick, asking Buildbucket for the build status
[02:44:16.563] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:16.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:118:0) after 1m0s
[02:45:16.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:118:0)
[02:45:16.605] Timer tick, asking Buildbucket for the build status
[02:45:17.479] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:17.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:119:0) after 1m0s
[02:46:17.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:119:0)
[02:46:17.579] Timer tick, asking Buildbucket for the build status
[02:46:18.231] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:18.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:120:0) after 1m0s
[02:47:18.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:120:0)
[02:47:18.324] Timer tick, asking Buildbucket for the build status
[02:47:19.238] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:19.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:121:0) after 1m0s
[02:48:19.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:121:0)
[02:48:19.274] Timer tick, asking Buildbucket for the build status
[02:48:19.513] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:19.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:122:0) after 1m0s
[02:49:19.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:122:0)
[02:49:19.571] Timer tick, asking Buildbucket for the build status
[02:49:19.752] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:19.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:123:0) after 1m0s
[02:50:19.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:123:0)
[02:50:19.882] Timer tick, asking Buildbucket for the build status
[02:50:20.388] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:20.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:124:0) after 1m0s
[02:51:20.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:124:0)
[02:51:20.474] Timer tick, asking Buildbucket for the build status
[02:51:24.178] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:24.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:125:0) after 1m0s
[02:52:24.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:125:0)
[02:52:24.295] Timer tick, asking Buildbucket for the build status
[02:52:24.496] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:24.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:126:0) after 1m0s
[02:53:24.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:126:0)
[02:53:24.542] Timer tick, asking Buildbucket for the build status
[02:53:27.524] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:27.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:127:0) after 1m0s
[02:54:27.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:127:0)
[02:54:27.559] Timer tick, asking Buildbucket for the build status
[02:54:28.406] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:28.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:128:0) after 1m0s
[02:55:28.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:128:0)
[02:55:28.511] Timer tick, asking Buildbucket for the build status
[02:55:29.114] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:29.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:129:0) after 1m0s
[02:56:29.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:129:0)
[02:56:29.171] Timer tick, asking Buildbucket for the build status
[02:56:29.785] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:29.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:130:0) after 1m0s
[02:57:29.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:130:0)
[02:57:29.870] Timer tick, asking Buildbucket for the build status
[02:57:30.751] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:30.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:131:0) after 1m0s
[02:58:30.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:131:0)
[02:58:30.833] Timer tick, asking Buildbucket for the build status
[02:58:33.817] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:132:0) after 1m0s
[02:59:33.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:132:0)
[02:59:33.952] Timer tick, asking Buildbucket for the build status
[02:59:34.564] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:34.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:133:0) after 1m0s
[03:00:34.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:133:0)
[03:00:34.703] Timer tick, asking Buildbucket for the build status
[03:00:34.991] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:34.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:134:0) after 1m0s
[03:01:35.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:134:0)
[03:01:35.082] Timer tick, asking Buildbucket for the build status
[03:01:35.278] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:35.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:135:0) after 1m0s
[03:02:35.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:135:0)
[03:02:35.342] Timer tick, asking Buildbucket for the build status
[03:02:35.637] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:35.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:136:0) after 1m0s
[03:03:35.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:136:0)
[03:03:35.675] Timer tick, asking Buildbucket for the build status
[03:03:35.865] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:35.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:137:0) after 1m0s
[03:04:35.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:137:0)
[03:04:35.907] Timer tick, asking Buildbucket for the build status
[03:04:36.175] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:36.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:138:0) after 1m0s
[03:05:36.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:138:0)
[03:05:36.248] Timer tick, asking Buildbucket for the build status
[03:05:36.552] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:36.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:139:0) after 1m0s
[03:06:36.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:139:0)
[03:06:36.589] Timer tick, asking Buildbucket for the build status
[03:06:36.879] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:36.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:140:0) after 1m0s
[03:07:36.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:140:0)
[03:07:36.969] Timer tick, asking Buildbucket for the build status
[03:07:37.152] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:37.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:141:0) after 1m0s
[03:08:37.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:141:0)
[03:08:37.202] Timer tick, asking Buildbucket for the build status
[03:08:37.738] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:37.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:142:0) after 1m0s
[03:09:37.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:142:0)
[03:09:37.744] Timer tick, asking Buildbucket for the build status
[03:09:38.357] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:38.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:143:0) after 1m0s
[03:10:38.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:143:0)
[03:10:38.457] Timer tick, asking Buildbucket for the build status
[03:10:39.577] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:39.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:144:0) after 1m0s
[03:11:39.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:144:0)
[03:11:39.637] Timer tick, asking Buildbucket for the build status
[03:11:39.859] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:39.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:145:0) after 1m0s
[03:12:39.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:145:0)
[03:12:39.908] Timer tick, asking Buildbucket for the build status
[03:12:40.154] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:40.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:146:0) after 1m0s
[03:13:40.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:146:0)
[03:13:40.248] Timer tick, asking Buildbucket for the build status
[03:13:40.429] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:40.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:147:0) after 1m0s
[03:14:40.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:147:0)
[03:14:40.463] Timer tick, asking Buildbucket for the build status
[03:14:40.656] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:40.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:148:0) after 1m0s
[03:15:40.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:148:0)
[03:15:40.688] Timer tick, asking Buildbucket for the build status
[03:15:40.845] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:40.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:149:0) after 1m0s
[03:16:40.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:149:0)
[03:16:40.991] Timer tick, asking Buildbucket for the build status
[03:16:41.727] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:41.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:150:0) after 1m0s
[03:17:41.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:150:0)
[03:17:41.756] Timer tick, asking Buildbucket for the build status
[03:17:42.459] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:42.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:151:0) after 1m0s
[03:18:42.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:151:0)
[03:18:42.493] Timer tick, asking Buildbucket for the build status
[03:18:42.737] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:42.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:152:0) after 1m0s
[03:19:42.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:152:0)
[03:19:42.762] Timer tick, asking Buildbucket for the build status
[03:19:42.927] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:42.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:153:0) after 1m0s
[03:20:43.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:153:0)
[03:20:43.022] Timer tick, asking Buildbucket for the build status
[03:20:43.478] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:43.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:154:0) after 1m0s
[03:21:43.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:154:0)
[03:21:43.533] Timer tick, asking Buildbucket for the build status
[03:21:43.852] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:43.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:155:0) after 1m0s
[03:22:44.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:155:0)
[03:22:44.139] Timer tick, asking Buildbucket for the build status
[03:22:44.333] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:44.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:156:0) after 1m0s
[03:23:44.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:156:0)
[03:23:44.392] Timer tick, asking Buildbucket for the build status
[03:23:45.431] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:45.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:157:0) after 1m0s
[03:24:45.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:157:0)
[03:24:45.480] Timer tick, asking Buildbucket for the build status
[03:24:45.709] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:158:0) after 1m0s
[03:25:45.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:158:0)
[03:25:45.752] Timer tick, asking Buildbucket for the build status
[03:25:46.786] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:46.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:159:0) after 1m0s
[03:26:46.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:159:0)
[03:26:46.952] Timer tick, asking Buildbucket for the build status
[03:26:47.311] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:47.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:160:0) after 1m0s
[03:27:47.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:160:0)
[03:27:47.395] Timer tick, asking Buildbucket for the build status
[03:27:48.271] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:48.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:161:0) after 1m0s
[03:28:48.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:161:0)
[03:28:48.399] Timer tick, asking Buildbucket for the build status
[03:28:50.323] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:50.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:162:0) after 1m0s
[03:29:50.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:162:0)
[03:29:50.363] Timer tick, asking Buildbucket for the build status
[03:29:50.491] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:50.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:163:0) after 1m0s
[03:30:50.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:163:0)
[03:30:50.655] Timer tick, asking Buildbucket for the build status
[03:30:52.011] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:52.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:164:0) after 1m0s
[03:31:52.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:164:0)
[03:31:52.141] Timer tick, asking Buildbucket for the build status
[03:31:52.413] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:52.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:165:0) after 1m0s
[03:32:52.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:165:0)
[03:32:52.529] Timer tick, asking Buildbucket for the build status
[03:32:52.761] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:52.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:166:0) after 1m0s
[03:33:52.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:166:0)
[03:33:52.788] Timer tick, asking Buildbucket for the build status
[03:33:53.020] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:53.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:167:0) after 1m0s
[03:34:53.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:167:0)
[03:34:53.161] Timer tick, asking Buildbucket for the build status
[03:34:54.282] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:168:0) after 1m0s
[03:35:54.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:168:0)
[03:35:54.320] Timer tick, asking Buildbucket for the build status
[03:35:54.814] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:54.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:169:0) after 1m0s
[03:36:54.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:169:0)
[03:36:54.850] Timer tick, asking Buildbucket for the build status
[03:36:56.855] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:56.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:170:0) after 1m0s
[03:37:56.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:170:0)
[03:37:56.913] Timer tick, asking Buildbucket for the build status
[03:37:57.125] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:57.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:171:0) after 1m0s
[03:38:57.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:171:0)
[03:38:57.157] Timer tick, asking Buildbucket for the build status
[03:38:57.437] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:57.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:172:0) after 1m0s
[03:39:57.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:172:0)
[03:39:57.516] Timer tick, asking Buildbucket for the build status
[03:39:57.718] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:57.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:173:0) after 1m0s
[03:40:57.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:173:0)
[03:40:57.828] Timer tick, asking Buildbucket for the build status
[03:40:59.466] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:59.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:174:0) after 1m0s
[03:41:59.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:174:0)
[03:41:59.572] Timer tick, asking Buildbucket for the build status
[03:42:00.919] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:00.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:175:0) after 1m0s
[03:43:01.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:175:0)
[03:43:01.147] Timer tick, asking Buildbucket for the build status
[03:43:04.614] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:04.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:176:0) after 1m0s
[03:44:04.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:176:0)
[03:44:04.700] Timer tick, asking Buildbucket for the build status
[03:44:04.967] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:04.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:177:0) after 1m0s
[03:45:05.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:177:0)
[03:45:05.081] Timer tick, asking Buildbucket for the build status
[03:45:05.583] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:05.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:178:0) after 1m0s
[03:46:05.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:178:0)
[03:46:05.667] Timer tick, asking Buildbucket for the build status
[03:46:05.858] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:05.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:179:0) after 1m0s
[03:47:05.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:179:0)
[03:47:05.997] Timer tick, asking Buildbucket for the build status
[03:47:06.796] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:06.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:180:0) after 1m0s
[03:48:07.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:180:0)
[03:48:07.002] Timer tick, asking Buildbucket for the build status
[03:48:07.854] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:07.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:181:0) after 1m0s
[03:49:07.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:181:0)
[03:49:07.919] Timer tick, asking Buildbucket for the build status
[03:49:08.028] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:08.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:182:0) after 1m0s
[03:50:08.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:182:0)
[03:50:08.039] Timer tick, asking Buildbucket for the build status
[03:50:08.669] Build 8902384055406237936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:08.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9067814118990204624:183:0) after 1m0s
[03:50:10.877] Received PubSub notification, asking Buildbucket for the build status
[03:50:11.361] Build 8902384055406237936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:50:11.361] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568433009835624",
"created_by": "project:chromium",
"created_ts": "1568421993782877",
"id": "8902384055406237936",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6cced4da95c416dd95dca80040a641b935492f0a\"}}",
"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-y5mg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14711, \"got_angle_revision\": \"6caa2652613b56f99c36e7a9c0cc2a547c5a9e59\", \"got_dawn_revision\": \"785ec66b66a3577e4f17306a10ab30b7f92c49ae\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"6cced4da95c416dd95dca80040a641b935492f0a\", \"got_revision_cp\": \"refs/heads/master@{#696608}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9d4f64830ea1bb9b7ea3b427f00418bea2e549f3\", \"got_v8_revision_cp\": \"refs/heads/7.9.39@{#1}\", \"got_webrtc_revision\": \"0dd37ce029f05234e081dbef4b2d53223349db29\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29187}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6cced4da95c416dd95dca80040a641b935492f0a\"}, \"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-y5mg\"], \"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\": [\"4436-e523514\"], \"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": "1568422109306324",
"status": "COMPLETED",
"status_changed_ts": "1568433010395180",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14711",
"builder:Windows deterministic",
"buildset:commit/git/6cced4da95c416dd95dca80040a641b935492f0a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6cced4da95c416dd95dca80040a641b935492f0a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067814118990204624",
"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/8902384055406237936/+/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:47460dfc7398e610",
"user_agent:luci-scheduler"
],
"updated_ts": "1568433010403911",
"url": "https://ci.chromium.org/b/8902384055406237936",
"utcnow_ts": "1568433011328335"
}
}
[03:50:11.362] Invocation finished in 3h3m40.380849022s with status SUCCEEDED