[07:50:22.530] New invocation is queued and will start shortly
[07:50:23.912] Starting the invocation (attempt 1)
[07:50:24.027] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:50:24.027] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:50:24.027] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070233570190646416",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"33bcd6a2204c163427970310cbd96ae0d02098d2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9070233570190646416",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/33bcd6a2204c163427970310cbd96ae0d02098d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33bcd6a2204c163427970310cbd96ae0d02098d2",
"gitiles_ref:refs/heads/master"
]
}
[07:50:25.104] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566114624420762",
"id": "8904803507542091504",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"33bcd6a2204c163427970310cbd96ae0d02098d2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566114624928436",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14455",
"builder:Windows deterministic",
"buildset:commit/git/33bcd6a2204c163427970310cbd96ae0d02098d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33bcd6a2204c163427970310cbd96ae0d02098d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070233570190646416",
"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/8904803507542091504/+/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": "1566114624928528",
"url": "https://ci.chromium.org/b/8904803507542091504",
"utcnow_ts": "1566114625086808"
}
}
[07:50:25.104] Task URL: https://ci.chromium.org/b/8904803507542091504
[07:50:25.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:2:0) after 1m0s
[07:51:25.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:2:0)
[07:51:25.126] Timer tick, asking Buildbucket for the build status
[07:51:25.530] Build 8904803507542091504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:3:0) after 1m0s
[07:52:25.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:3:0)
[07:52:25.558] Timer tick, asking Buildbucket for the build status
[07:52:25.827] Build 8904803507542091504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:25.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:4:0) after 1m0s
[07:52:47.072] Received PubSub notification, asking Buildbucket for the build status
[07:52:47.205] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:25.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:4:0)
[07:53:25.851] Timer tick, asking Buildbucket for the build status
[07:53:26.035] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:26.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:6:0) after 1m0s
[07:54:26.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:6:0)
[07:54:26.066] Timer tick, asking Buildbucket for the build status
[07:54:26.224] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:26.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:7:0) after 1m0s
[07:55:26.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:7:0)
[07:55:26.264] Timer tick, asking Buildbucket for the build status
[07:55:26.749] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:26.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:8:0) after 1m0s
[07:56:26.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:8:0)
[07:56:26.783] Timer tick, asking Buildbucket for the build status
[07:56:27.303] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:27.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:9:0) after 1m0s
[07:57:27.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:9:0)
[07:57:27.326] Timer tick, asking Buildbucket for the build status
[07:57:27.478] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:27.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:10:0) after 1m0s
[07:58:27.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:10:0)
[07:58:27.500] Timer tick, asking Buildbucket for the build status
[07:58:28.248] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:28.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:11:0) after 1m0s
[07:59:28.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:11:0)
[07:59:28.278] Timer tick, asking Buildbucket for the build status
[07:59:29.367] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:29.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:12:0) after 1m0s
[08:00:29.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:12:0)
[08:00:29.388] Timer tick, asking Buildbucket for the build status
[08:00:30.038] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:30.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:13:0) after 1m0s
[08:01:30.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:13:0)
[08:01:30.082] Timer tick, asking Buildbucket for the build status
[08:01:30.370] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:30.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:14:0) after 1m0s
[08:02:30.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:14:0)
[08:02:30.393] Timer tick, asking Buildbucket for the build status
[08:02:30.552] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:30.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:15:0) after 1m0s
[08:03:30.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:15:0)
[08:03:30.602] Timer tick, asking Buildbucket for the build status
[08:03:31.038] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:31.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:16:0) after 1m0s
[08:04:31.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:16:0)
[08:04:31.085] Timer tick, asking Buildbucket for the build status
[08:04:31.407] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:31.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:17:0) after 1m0s
[08:05:31.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:17:0)
[08:05:31.477] Timer tick, asking Buildbucket for the build status
[08:05:31.635] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:18:0) after 1m0s
[08:06:31.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:18:0)
[08:06:31.760] Timer tick, asking Buildbucket for the build status
[08:06:31.929] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:31.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:19:0) after 1m0s
[08:07:31.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:19:0)
[08:07:31.973] Timer tick, asking Buildbucket for the build status
[08:07:32.420] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:32.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:20:0) after 1m0s
[08:08:32.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:20:0)
[08:08:32.471] Timer tick, asking Buildbucket for the build status
[08:08:33.013] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:33.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:21:0) after 1m0s
[08:09:33.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:21:0)
[08:09:33.038] Timer tick, asking Buildbucket for the build status
[08:09:33.312] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:33.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:22:0) after 1m0s
[08:10:33.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:22:0)
[08:10:33.344] Timer tick, asking Buildbucket for the build status
[08:10:33.600] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:33.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:23:0) after 1m0s
[08:11:33.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:23:0)
[08:11:33.626] Timer tick, asking Buildbucket for the build status
[08:11:35.253] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:35.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:24:0) after 1m0s
[08:12:35.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:24:0)
[08:12:35.477] Timer tick, asking Buildbucket for the build status
[08:12:35.917] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:35.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:25:0) after 1m0s
[08:13:36.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:25:0)
[08:13:36.861] Timer tick, asking Buildbucket for the build status
[08:13:37.457] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:37.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:26:0) after 1m0s
[08:14:37.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:26:0)
[08:14:37.700] Timer tick, asking Buildbucket for the build status
[08:14:37.886] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:37.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:27:0) after 1m0s
[08:15:38.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:27:0)
[08:15:38.093] Timer tick, asking Buildbucket for the build status
[08:15:38.900] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:28:0) after 1m0s
[08:16:39.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:28:0)
[08:16:39.095] Timer tick, asking Buildbucket for the build status
[08:16:39.992] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:39.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:29:0) after 1m0s
[08:17:40.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:29:0)
[08:17:40.456] Timer tick, asking Buildbucket for the build status
[08:17:40.863] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:40.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:30:0) after 1m0s
[08:18:40.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:30:0)
[08:18:40.981] Timer tick, asking Buildbucket for the build status
[08:18:41.128] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:31:0) after 1m0s
[08:19:41.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:31:0)
[08:19:41.349] Timer tick, asking Buildbucket for the build status
[08:19:42.135] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:42.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:32:0) after 1m0s
[08:20:42.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:32:0)
[08:20:42.481] Timer tick, asking Buildbucket for the build status
[08:20:42.653] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:42.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:33:0) after 1m0s
[08:21:43.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:33:0)
[08:21:43.070] Timer tick, asking Buildbucket for the build status
[08:21:43.392] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:43.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:34:0) after 1m0s
[08:22:43.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:34:0)
[08:22:43.417] Timer tick, asking Buildbucket for the build status
[08:22:43.547] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:43.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:35:0) after 1m0s
[08:23:44.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:35:0)
[08:23:44.053] Timer tick, asking Buildbucket for the build status
[08:23:44.178] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:44.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:36:0) after 1m0s
[08:24:44.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:36:0)
[08:24:44.599] Timer tick, asking Buildbucket for the build status
[08:24:45.138] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:45.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:37:0) after 1m0s
[08:25:45.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:37:0)
[08:25:45.207] Timer tick, asking Buildbucket for the build status
[08:25:45.416] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:45.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:38:0) after 1m0s
[08:26:45.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:38:0)
[08:26:45.535] Timer tick, asking Buildbucket for the build status
[08:26:45.683] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:45.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:39:0) after 1m0s
[08:27:45.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:39:0)
[08:27:45.988] Timer tick, asking Buildbucket for the build status
[08:27:46.145] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:46.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:40:0) after 1m0s
[08:28:46.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:40:0)
[08:28:46.276] Timer tick, asking Buildbucket for the build status
[08:28:46.483] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:46.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:41:0) after 1m0s
[08:29:46.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:41:0)
[08:29:46.551] Timer tick, asking Buildbucket for the build status
[08:29:46.884] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:46.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:42:0) after 1m0s
[08:30:46.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:42:0)
[08:30:46.973] Timer tick, asking Buildbucket for the build status
[08:30:47.122] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:47.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:43:0) after 1m0s
[08:31:47.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:43:0)
[08:31:47.169] Timer tick, asking Buildbucket for the build status
[08:31:47.289] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:47.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:44:0) after 1m0s
[08:32:47.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:44:0)
[08:32:47.317] Timer tick, asking Buildbucket for the build status
[08:32:47.489] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:47.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:45:0) after 1m0s
[08:33:47.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:45:0)
[08:33:47.512] Timer tick, asking Buildbucket for the build status
[08:33:48.696] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:48.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:46:0) after 1m0s
[08:34:48.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:46:0)
[08:34:48.730] Timer tick, asking Buildbucket for the build status
[08:34:49.314] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:49.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:47:0) after 1m0s
[08:35:59.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:47:0)
[08:35:59.800] Timer tick, asking Buildbucket for the build status
[08:35:59.981] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:59.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:48:0) after 1m0s
[08:37:00.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:48:0)
[08:37:00.014] Timer tick, asking Buildbucket for the build status
[08:37:00.749] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:00.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:49:0) after 1m0s
[08:38:00.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:49:0)
[08:38:00.815] Timer tick, asking Buildbucket for the build status
[08:38:01.169] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:01.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:50:0) after 1m0s
[08:39:01.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:50:0)
[08:39:01.194] Timer tick, asking Buildbucket for the build status
[08:39:01.584] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:01.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:51:0) after 1m0s
[08:40:01.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:51:0)
[08:40:01.705] Timer tick, asking Buildbucket for the build status
[08:40:02.077] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:02.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:52:0) after 1m0s
[08:41:02.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:52:0)
[08:41:02.105] Timer tick, asking Buildbucket for the build status
[08:41:02.305] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:02.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:53:0) after 1m0s
[08:42:02.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:53:0)
[08:42:02.354] Timer tick, asking Buildbucket for the build status
[08:42:02.718] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:02.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:54:0) after 1m0s
[08:43:02.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:54:0)
[08:43:02.743] Timer tick, asking Buildbucket for the build status
[08:43:02.918] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:02.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:55:0) after 1m0s
[08:44:02.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:55:0)
[08:44:02.954] Timer tick, asking Buildbucket for the build status
[08:44:03.404] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:03.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:56:0) after 1m0s
[08:45:03.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:56:0)
[08:45:03.517] Timer tick, asking Buildbucket for the build status
[08:45:04.356] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:04.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:57:0) after 1m0s
[08:46:04.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:57:0)
[08:46:04.500] Timer tick, asking Buildbucket for the build status
[08:46:04.756] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:04.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:58:0) after 1m0s
[08:47:04.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:58:0)
[08:47:04.890] Timer tick, asking Buildbucket for the build status
[08:47:05.044] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:05.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:59:0) after 1m0s
[08:48:05.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:59:0)
[08:48:05.095] Timer tick, asking Buildbucket for the build status
[08:48:05.434] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:05.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:60:0) after 1m0s
[08:49:05.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:60:0)
[08:49:05.675] Timer tick, asking Buildbucket for the build status
[08:49:06.108] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:06.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:61:0) after 1m0s
[08:50:06.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:61:0)
[08:50:06.079] Timer tick, asking Buildbucket for the build status
[08:50:06.758] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:06.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:62:0) after 1m0s
[08:51:06.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:62:0)
[08:51:06.843] Timer tick, asking Buildbucket for the build status
[08:51:07.026] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:07.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:63:0) after 1m0s
[08:52:07.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:63:0)
[08:52:07.068] Timer tick, asking Buildbucket for the build status
[08:52:07.646] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:07.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:64:0) after 1m0s
[08:53:07.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:64:0)
[08:53:07.712] Timer tick, asking Buildbucket for the build status
[08:53:08.733] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:08.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:65:0) after 1m0s
[08:54:08.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:65:0)
[08:54:08.795] Timer tick, asking Buildbucket for the build status
[08:54:09.799] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:09.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:66:0) after 1m0s
[08:55:09.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:66:0)
[08:55:09.923] Timer tick, asking Buildbucket for the build status
[08:55:10.180] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:10.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:67:0) after 1m0s
[08:56:10.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:67:0)
[08:56:10.208] Timer tick, asking Buildbucket for the build status
[08:56:10.813] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:10.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:68:0) after 1m0s
[08:57:10.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:68:0)
[08:57:10.910] Timer tick, asking Buildbucket for the build status
[08:57:11.101] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:11.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:69:0) after 1m0s
[08:58:11.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:69:0)
[08:58:11.179] Timer tick, asking Buildbucket for the build status
[08:58:11.734] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:11.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:70:0) after 1m0s
[08:59:11.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:70:0)
[08:59:11.928] Timer tick, asking Buildbucket for the build status
[08:59:14.937] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:14.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:71:0) after 1m0s
[09:00:15.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:71:0)
[09:00:15.002] Timer tick, asking Buildbucket for the build status
[09:00:16.145] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:16.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:72:0) after 1m0s
[09:01:16.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:72:0)
[09:01:16.221] Timer tick, asking Buildbucket for the build status
[09:01:16.390] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:16.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:73:0) after 1m0s
[09:02:16.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:73:0)
[09:02:16.447] Timer tick, asking Buildbucket for the build status
[09:02:17.608] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:17.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:74:0) after 1m0s
[09:03:17.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:74:0)
[09:03:17.671] Timer tick, asking Buildbucket for the build status
[09:03:17.865] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:17.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:75:0) after 1m0s
[09:04:17.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:75:0)
[09:04:17.993] Timer tick, asking Buildbucket for the build status
[09:04:18.464] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:76:0) after 1m0s
[09:05:18.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:76:0)
[09:05:18.543] Timer tick, asking Buildbucket for the build status
[09:05:20.442] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:20.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:77:0) after 1m0s
[09:06:20.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:77:0)
[09:06:20.577] Timer tick, asking Buildbucket for the build status
[09:06:20.842] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:20.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:78:0) after 1m0s
[09:07:20.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:78:0)
[09:07:20.903] Timer tick, asking Buildbucket for the build status
[09:07:21.115] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:21.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:79:0) after 1m0s
[09:08:21.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:79:0)
[09:08:21.154] Timer tick, asking Buildbucket for the build status
[09:08:21.335] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:21.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:80:0) after 1m0s
[09:09:21.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:80:0)
[09:09:21.361] Timer tick, asking Buildbucket for the build status
[09:09:21.780] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:21.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:81:0) after 1m0s
[09:10:21.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:81:0)
[09:10:21.892] Timer tick, asking Buildbucket for the build status
[09:10:22.995] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:22.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:82:0) after 1m0s
[09:11:23.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:82:0)
[09:11:23.024] Timer tick, asking Buildbucket for the build status
[09:11:23.234] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:23.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:83:0) after 1m0s
[09:12:23.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:83:0)
[09:12:23.378] Timer tick, asking Buildbucket for the build status
[09:12:23.615] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:23.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:84:0) after 1m0s
[09:13:23.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:84:0)
[09:13:23.732] Timer tick, asking Buildbucket for the build status
[09:13:24.119] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:24.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:85:0) after 1m0s
[09:14:24.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:85:0)
[09:14:24.145] Timer tick, asking Buildbucket for the build status
[09:14:24.560] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:24.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:86:0) after 1m0s
[09:15:24.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:86:0)
[09:15:24.639] Timer tick, asking Buildbucket for the build status
[09:15:24.832] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:24.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:87:0) after 1m0s
[09:16:33.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:87:0)
[09:16:33.231] Timer tick, asking Buildbucket for the build status
[09:16:36.128] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:36.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:88:0) after 1m0s
[09:17:36.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:88:0)
[09:17:36.417] Timer tick, asking Buildbucket for the build status
[09:17:36.595] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:36.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:89:0) after 1m0s
[09:18:36.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:89:0)
[09:18:36.698] Timer tick, asking Buildbucket for the build status
[09:18:36.849] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:36.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:90:0) after 1m0s
[09:19:36.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:90:0)
[09:19:36.947] Timer tick, asking Buildbucket for the build status
[09:19:37.164] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:37.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:91:0) after 1m0s
[09:20:37.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:91:0)
[09:20:37.249] Timer tick, asking Buildbucket for the build status
[09:20:40.069] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:40.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:92:0) after 1m0s
[09:21:40.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:92:0)
[09:21:40.100] Timer tick, asking Buildbucket for the build status
[09:21:40.547] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:40.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:93:0) after 1m0s
[09:22:40.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:93:0)
[09:22:40.582] Timer tick, asking Buildbucket for the build status
[09:22:41.007] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:41.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:94:0) after 1m0s
[09:23:41.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:94:0)
[09:23:41.017] Timer tick, asking Buildbucket for the build status
[09:23:42.240] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:42.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:95:0) after 1m0s
[09:24:42.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:95:0)
[09:24:42.304] Timer tick, asking Buildbucket for the build status
[09:24:42.532] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:42.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:96:0) after 1m0s
[09:25:42.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:96:0)
[09:25:42.535] Timer tick, asking Buildbucket for the build status
[09:25:43.413] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:43.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:97:0) after 1m0s
[09:26:43.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:97:0)
[09:26:43.453] Timer tick, asking Buildbucket for the build status
[09:26:43.766] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:43.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:98:0) after 1m0s
[09:27:43.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:98:0)
[09:27:43.791] Timer tick, asking Buildbucket for the build status
[09:27:44.010] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:44.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:99:0) after 1m0s
[09:28:44.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:99:0)
[09:28:44.055] Timer tick, asking Buildbucket for the build status
[09:28:44.194] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:44.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:100:0) after 1m0s
[09:29:44.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:100:0)
[09:29:44.389] Timer tick, asking Buildbucket for the build status
[09:29:44.895] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:44.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:101:0) after 1m0s
[09:30:45.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:101:0)
[09:30:45.024] Timer tick, asking Buildbucket for the build status
[09:30:49.929] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:49.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:102:0) after 1m0s
[09:31:49.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:102:0)
[09:31:49.959] Timer tick, asking Buildbucket for the build status
[09:31:50.216] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:50.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:103:0) after 1m0s
[09:32:50.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:103:0)
[09:32:50.246] Timer tick, asking Buildbucket for the build status
[09:32:50.611] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:50.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:104:0) after 1m0s
[09:33:50.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:104:0)
[09:33:50.696] Timer tick, asking Buildbucket for the build status
[09:33:51.137] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:51.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:105:0) after 1m0s
[09:34:51.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:105:0)
[09:34:51.165] Timer tick, asking Buildbucket for the build status
[09:34:51.366] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:51.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:106:0) after 1m0s
[09:35:51.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:106:0)
[09:35:51.401] Timer tick, asking Buildbucket for the build status
[09:35:52.414] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:52.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:107:0) after 1m0s
[09:36:52.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:107:0)
[09:36:52.455] Timer tick, asking Buildbucket for the build status
[09:36:52.674] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:52.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:108:0) after 1m0s
[09:37:52.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:108:0)
[09:37:52.700] Timer tick, asking Buildbucket for the build status
[09:37:53.567] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:53.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:109:0) after 1m0s
[09:38:53.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:109:0)
[09:38:53.608] Timer tick, asking Buildbucket for the build status
[09:38:53.891] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:53.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:110:0) after 1m0s
[09:39:53.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:110:0)
[09:39:53.983] Timer tick, asking Buildbucket for the build status
[09:39:54.374] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:54.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:111:0) after 1m0s
[09:40:55.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:111:0)
[09:40:55.467] Timer tick, asking Buildbucket for the build status
[09:40:56.227] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:56.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:112:0) after 1m0s
[09:41:56.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:112:0)
[09:41:56.885] Timer tick, asking Buildbucket for the build status
[09:41:57.102] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:113:0) after 1m0s
[09:42:57.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:113:0)
[09:42:57.403] Timer tick, asking Buildbucket for the build status
[09:42:57.993] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:57.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:114:0) after 1m0s
[09:43:58.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:114:0)
[09:43:58.315] Timer tick, asking Buildbucket for the build status
[09:43:58.660] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:58.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:115:0) after 1m0s
[09:44:58.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:115:0)
[09:44:58.847] Timer tick, asking Buildbucket for the build status
[09:44:59.068] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:59.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:116:0) after 1m0s
[09:45:59.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:116:0)
[09:45:59.203] Timer tick, asking Buildbucket for the build status
[09:45:59.533] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:59.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:117:0) after 1m0s
[09:46:59.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:117:0)
[09:46:59.685] Timer tick, asking Buildbucket for the build status
[09:47:00.109] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:00.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:118:0) after 1m0s
[09:48:00.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:118:0)
[09:48:00.231] Timer tick, asking Buildbucket for the build status
[09:48:00.381] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:00.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:119:0) after 1m0s
[09:49:00.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:119:0)
[09:49:00.533] Timer tick, asking Buildbucket for the build status
[09:49:01.113] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:01.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:120:0) after 1m0s
[09:50:01.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:120:0)
[09:50:01.421] Timer tick, asking Buildbucket for the build status
[09:50:01.616] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:01.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:121:0) after 1m0s
[09:51:01.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:121:0)
[09:51:01.667] Timer tick, asking Buildbucket for the build status
[09:51:01.882] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:01.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:122:0) after 1m0s
[09:52:01.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:122:0)
[09:52:01.944] Timer tick, asking Buildbucket for the build status
[09:52:02.339] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:02.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:123:0) after 1m0s
[09:53:02.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:123:0)
[09:53:02.481] Timer tick, asking Buildbucket for the build status
[09:53:03.054] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:03.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:124:0) after 1m0s
[09:54:03.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:124:0)
[09:54:03.197] Timer tick, asking Buildbucket for the build status
[09:54:03.690] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:03.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:125:0) after 1m0s
[09:55:03.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:125:0)
[09:55:03.723] Timer tick, asking Buildbucket for the build status
[09:55:03.897] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:03.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:126:0) after 1m0s
[09:56:04.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:126:0)
[09:56:04.126] Timer tick, asking Buildbucket for the build status
[09:56:04.293] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:04.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:127:0) after 1m0s
[09:57:04.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:127:0)
[09:57:04.423] Timer tick, asking Buildbucket for the build status
[09:57:04.647] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:04.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:128:0) after 1m0s
[09:58:04.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:128:0)
[09:58:04.935] Timer tick, asking Buildbucket for the build status
[09:58:05.925] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:05.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:129:0) after 1m0s
[09:59:06.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:129:0)
[09:59:06.053] Timer tick, asking Buildbucket for the build status
[09:59:06.236] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:06.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:130:0) after 1m0s
[10:00:06.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:130:0)
[10:00:06.346] Timer tick, asking Buildbucket for the build status
[10:00:06.521] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:06.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:131:0) after 1m0s
[10:01:07.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:131:0)
[10:01:07.008] Timer tick, asking Buildbucket for the build status
[10:01:07.206] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:07.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:132:0) after 1m0s
[10:02:07.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:132:0)
[10:02:07.231] Timer tick, asking Buildbucket for the build status
[10:02:07.762] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:07.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:133:0) after 1m0s
[10:03:07.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:133:0)
[10:03:07.791] Timer tick, asking Buildbucket for the build status
[10:03:10.758] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:10.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:134:0) after 1m0s
[10:04:10.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:134:0)
[10:04:10.885] Timer tick, asking Buildbucket for the build status
[10:04:11.092] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:135:0) after 1m0s
[10:05:11.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:135:0)
[10:05:11.130] Timer tick, asking Buildbucket for the build status
[10:05:11.816] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:11.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:136:0) after 1m0s
[10:06:11.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:136:0)
[10:06:11.879] Timer tick, asking Buildbucket for the build status
[10:06:12.104] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:12.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:137:0) after 1m0s
[10:07:12.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:137:0)
[10:07:12.350] Timer tick, asking Buildbucket for the build status
[10:07:12.648] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:12.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:138:0) after 1m0s
[10:08:12.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:138:0)
[10:08:12.675] Timer tick, asking Buildbucket for the build status
[10:08:15.025] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:15.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:139:0) after 1m0s
[10:09:15.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:139:0)
[10:09:15.028] Timer tick, asking Buildbucket for the build status
[10:09:15.546] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:15.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:140:0) after 1m0s
[10:10:15.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:140:0)
[10:10:15.598] Timer tick, asking Buildbucket for the build status
[10:10:15.763] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:15.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:141:0) after 1m0s
[10:11:15.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:141:0)
[10:11:15.798] Timer tick, asking Buildbucket for the build status
[10:11:16.124] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:16.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:142:0) after 1m0s
[10:12:16.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:142:0)
[10:12:16.172] Timer tick, asking Buildbucket for the build status
[10:12:16.587] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:16.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:143:0) after 1m0s
[10:13:16.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:143:0)
[10:13:16.620] Timer tick, asking Buildbucket for the build status
[10:13:16.923] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:16.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:144:0) after 1m0s
[10:14:16.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:144:0)
[10:14:16.973] Timer tick, asking Buildbucket for the build status
[10:14:17.827] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:17.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:145:0) after 1m0s
[10:15:17.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:145:0)
[10:15:17.916] Timer tick, asking Buildbucket for the build status
[10:15:18.374] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:18.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:146:0) after 1m0s
[10:16:18.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:146:0)
[10:16:18.403] Timer tick, asking Buildbucket for the build status
[10:16:18.667] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:18.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:147:0) after 1m0s
[10:17:18.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:147:0)
[10:17:18.756] Timer tick, asking Buildbucket for the build status
[10:17:19.487] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:19.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:148:0) after 1m0s
[10:18:19.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:148:0)
[10:18:19.512] Timer tick, asking Buildbucket for the build status
[10:18:19.644] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:19.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:149:0) after 1m0s
[10:19:19.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:149:0)
[10:19:19.786] Timer tick, asking Buildbucket for the build status
[10:19:21.072] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:21.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:150:0) after 1m0s
[10:20:21.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:150:0)
[10:20:21.103] Timer tick, asking Buildbucket for the build status
[10:20:21.276] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:21.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:151:0) after 1m0s
[10:21:21.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:151:0)
[10:21:21.332] Timer tick, asking Buildbucket for the build status
[10:21:21.575] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:21.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:152:0) after 1m0s
[10:22:21.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:152:0)
[10:22:21.617] Timer tick, asking Buildbucket for the build status
[10:22:21.779] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:21.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:153:0) after 1m0s
[10:23:21.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:153:0)
[10:23:21.842] Timer tick, asking Buildbucket for the build status
[10:23:22.381] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:22.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:154:0) after 1m0s
[10:24:22.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:154:0)
[10:24:22.458] Timer tick, asking Buildbucket for the build status
[10:24:23.040] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:23.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:155:0) after 1m0s
[10:25:23.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:155:0)
[10:25:23.544] Timer tick, asking Buildbucket for the build status
[10:25:24.268] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:24.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:156:0) after 1m0s
[10:26:24.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:156:0)
[10:26:24.664] Timer tick, asking Buildbucket for the build status
[10:26:24.825] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:24.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:157:0) after 1m0s
[10:27:24.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:157:0)
[10:27:24.852] Timer tick, asking Buildbucket for the build status
[10:27:25.354] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:25.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:158:0) after 1m0s
[10:28:25.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:158:0)
[10:28:25.443] Timer tick, asking Buildbucket for the build status
[10:28:25.668] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:25.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:159:0) after 1m0s
[10:29:25.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:159:0)
[10:29:25.701] Timer tick, asking Buildbucket for the build status
[10:29:25.912] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:25.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:160:0) after 1m0s
[10:30:25.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:160:0)
[10:30:25.951] Timer tick, asking Buildbucket for the build status
[10:30:26.152] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:26.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:161:0) after 1m0s
[10:31:26.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:161:0)
[10:31:26.388] Timer tick, asking Buildbucket for the build status
[10:31:27.744] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:27.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:162:0) after 1m0s
[10:32:27.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:162:0)
[10:32:27.871] Timer tick, asking Buildbucket for the build status
[10:32:28.139] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:28.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:163:0) after 1m0s
[10:33:28.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:163:0)
[10:33:28.170] Timer tick, asking Buildbucket for the build status
[10:33:28.456] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:28.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:164:0) after 1m0s
[10:34:28.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:164:0)
[10:34:28.595] Timer tick, asking Buildbucket for the build status
[10:34:29.021] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:29.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:165:0) after 1m0s
[10:35:29.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:165:0)
[10:35:29.170] Timer tick, asking Buildbucket for the build status
[10:35:29.300] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:29.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:166:0) after 1m0s
[10:36:29.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:166:0)
[10:36:29.613] Timer tick, asking Buildbucket for the build status
[10:36:30.115] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:30.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:167:0) after 1m0s
[10:37:30.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:167:0)
[10:37:30.197] Timer tick, asking Buildbucket for the build status
[10:37:30.394] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:30.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:168:0) after 1m0s
[10:38:30.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:168:0)
[10:38:30.463] Timer tick, asking Buildbucket for the build status
[10:38:30.976] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:30.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:169:0) after 1m0s
[10:39:31.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:169:0)
[10:39:31.088] Timer tick, asking Buildbucket for the build status
[10:39:31.555] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:31.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:170:0) after 1m0s
[10:40:31.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:170:0)
[10:40:31.798] Timer tick, asking Buildbucket for the build status
[10:40:31.997] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:31.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:171:0) after 1m0s
[10:41:32.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:171:0)
[10:41:32.305] Timer tick, asking Buildbucket for the build status
[10:41:33.321] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:33.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:172:0) after 1m0s
[10:42:33.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:172:0)
[10:42:33.420] Timer tick, asking Buildbucket for the build status
[10:42:33.562] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:33.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:173:0) after 1m0s
[10:43:33.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:173:0)
[10:43:33.814] Timer tick, asking Buildbucket for the build status
[10:43:33.968] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:33.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:174:0) after 1m0s
[10:44:34.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:174:0)
[10:44:34.034] Timer tick, asking Buildbucket for the build status
[10:44:34.167] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:34.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:175:0) after 1m0s
[10:45:34.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:175:0)
[10:45:34.249] Timer tick, asking Buildbucket for the build status
[10:45:34.788] Build 8904803507542091504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:34.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9070233570190646416:176:0) after 1m0s
[10:46:21.994] Received PubSub notification, asking Buildbucket for the build status
[10:46:22.281] Build 8904803507542091504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:46:22.281] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566125179812401",
"created_by": "project:chromium",
"created_ts": "1566114624420762",
"id": "8904803507542091504",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"33bcd6a2204c163427970310cbd96ae0d02098d2\"}}",
"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-q2vi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14455, \"got_angle_revision\": \"265fdf0c5fd6b1e28a54c18ca40a8461c7f449a7\", \"got_dawn_revision\": \"ee3de1e1f3da2386197a2c586304deb263890a35\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"33bcd6a2204c163427970310cbd96ae0d02098d2\", \"got_revision_cp\": \"refs/heads/master@{#687963}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7b861aca66ea8080a32eba6217f8833cdcc32a09\", \"got_v8_revision_cp\": \"refs/heads/7.8.113@{#1}\", \"got_webrtc_revision\": \"f5e5d250bc85616e74487f8330ed8d99cc9cf84f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28880}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"33bcd6a2204c163427970310cbd96ae0d02098d2\"}, \"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-q2vi\"], \"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": "1566114766061583",
"status": "COMPLETED",
"status_changed_ts": "1566125180160610",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14455",
"builder:Windows deterministic",
"buildset:commit/git/33bcd6a2204c163427970310cbd96ae0d02098d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33bcd6a2204c163427970310cbd96ae0d02098d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070233570190646416",
"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/8904803507542091504/+/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:46bc8643d15ec810",
"user_agent:luci-scheduler"
],
"updated_ts": "1566125180166690",
"url": "https://ci.chromium.org/b/8904803507542091504",
"utcnow_ts": "1566125182262946"
}
}
[10:46:22.281] Invocation finished in 2h55m59.770553307s with status SUCCEEDED