[06:27:42.404] New invocation is queued and will start shortly
[06:27:43.519] Starting the invocation (attempt 1)
[06:27:43.565] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:27:43.565] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:27:43.565] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068789219809555312",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f4952ec921e83c1399dbcef76774ded442cd948e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9068789219809555312",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/f4952ec921e83c1399dbcef76774ded442cd948e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f4952ec921e83c1399dbcef76774ded442cd948e",
"gitiles_ref:refs/heads/master"
]
}
[06:27:44.639] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567492063812860",
"id": "8903359157654659360",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f4952ec921e83c1399dbcef76774ded442cd948e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567492064415535",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14613",
"builder:Windows deterministic",
"buildset:commit/git/f4952ec921e83c1399dbcef76774ded442cd948e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f4952ec921e83c1399dbcef76774ded442cd948e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068789219809555312",
"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/8903359157654659360/+/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": "1567492064415638",
"url": "https://ci.chromium.org/b/8903359157654659360",
"utcnow_ts": "1567492064622970"
}
}
[06:27:44.639] Task URL: https://ci.chromium.org/b/8903359157654659360
[06:27:44.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:2:0) after 1m0s
[06:27:47.766] Received PubSub notification, asking Buildbucket for the build status
[06:27:48.258] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:44.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:2:0)
[06:28:44.657] Timer tick, asking Buildbucket for the build status
[06:28:45.055] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:45.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:4:0) after 1m0s
[06:29:45.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:4:0)
[06:29:45.144] Timer tick, asking Buildbucket for the build status
[06:29:45.366] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:45.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:5:0) after 1m0s
[06:30:45.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:5:0)
[06:30:45.461] Timer tick, asking Buildbucket for the build status
[06:30:46.257] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:46.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:6:0) after 1m0s
[06:31:46.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:6:0)
[06:31:46.339] Timer tick, asking Buildbucket for the build status
[06:31:49.094] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:49.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:7:0) after 1m0s
[06:32:49.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:7:0)
[06:32:49.115] Timer tick, asking Buildbucket for the build status
[06:32:49.708] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:49.708] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:8:0) after 1m0s
[06:33:49.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:8:0)
[06:33:49.756] Timer tick, asking Buildbucket for the build status
[06:33:50.228] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:50.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:9:0) after 1m0s
[06:34:50.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:9:0)
[06:34:50.251] Timer tick, asking Buildbucket for the build status
[06:34:54.842] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:10:0) after 1m0s
[06:35:54.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:10:0)
[06:35:54.922] Timer tick, asking Buildbucket for the build status
[06:35:55.745] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:55.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:11:0) after 1m0s
[06:36:55.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:11:0)
[06:36:55.770] Timer tick, asking Buildbucket for the build status
[06:36:57.602] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:57.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:12:0) after 1m0s
[06:37:57.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:12:0)
[06:37:57.639] Timer tick, asking Buildbucket for the build status
[06:37:58.048] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:58.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:13:0) after 1m0s
[06:38:58.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:13:0)
[06:38:58.093] Timer tick, asking Buildbucket for the build status
[06:39:00.542] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:00.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:14:0) after 1m0s
[06:40:00.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:14:0)
[06:40:00.643] Timer tick, asking Buildbucket for the build status
[06:40:01.734] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:01.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:15:0) after 1m0s
[06:41:01.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:15:0)
[06:41:01.745] Timer tick, asking Buildbucket for the build status
[06:41:01.936] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:01.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:16:0) after 1m0s
[06:42:01.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:16:0)
[06:42:01.909] Timer tick, asking Buildbucket for the build status
[06:42:02.374] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:02.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:17:0) after 1m0s
[06:43:02.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:17:0)
[06:43:02.448] Timer tick, asking Buildbucket for the build status
[06:43:03.032] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:03.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:18:0) after 1m0s
[06:44:03.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:18:0)
[06:44:03.048] Timer tick, asking Buildbucket for the build status
[06:44:03.615] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:03.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:19:0) after 1m0s
[06:45:03.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:19:0)
[06:45:03.646] Timer tick, asking Buildbucket for the build status
[06:45:06.502] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:06.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:20:0) after 1m0s
[06:46:06.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:20:0)
[06:46:06.536] Timer tick, asking Buildbucket for the build status
[06:46:09.609] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:09.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:21:0) after 1m0s
[06:47:09.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:21:0)
[06:47:09.709] Timer tick, asking Buildbucket for the build status
[06:47:09.966] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:09.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:22:0) after 1m0s
[06:48:09.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:22:0)
[06:48:09.962] Timer tick, asking Buildbucket for the build status
[06:48:10.480] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:10.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:23:0) after 1m0s
[06:49:10.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:23:0)
[06:49:10.512] Timer tick, asking Buildbucket for the build status
[06:49:10.799] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:10.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:24:0) after 1m0s
[06:50:10.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:24:0)
[06:50:10.847] Timer tick, asking Buildbucket for the build status
[06:50:11.119] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:11.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:25:0) after 1m0s
[06:51:11.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:25:0)
[06:51:11.097] Timer tick, asking Buildbucket for the build status
[06:51:11.467] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:11.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:26:0) after 1m0s
[06:52:11.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:26:0)
[06:52:11.500] Timer tick, asking Buildbucket for the build status
[06:52:14.648] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:14.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:27:0) after 1m0s
[06:53:14.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:27:0)
[06:53:14.719] Timer tick, asking Buildbucket for the build status
[06:53:14.903] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:14.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:28:0) after 1m0s
[06:54:14.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:28:0)
[06:54:14.999] Timer tick, asking Buildbucket for the build status
[06:54:15.451] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:15.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:29:0) after 1m0s
[06:55:15.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:29:0)
[06:55:15.524] Timer tick, asking Buildbucket for the build status
[06:55:16.863] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:16.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:30:0) after 1m0s
[06:56:16.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:30:0)
[06:56:16.893] Timer tick, asking Buildbucket for the build status
[06:56:17.396] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:17.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:31:0) after 1m0s
[06:57:17.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:31:0)
[06:57:17.419] Timer tick, asking Buildbucket for the build status
[06:57:19.942] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:19.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:32:0) after 1m0s
[06:58:19.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:32:0)
[06:58:19.963] Timer tick, asking Buildbucket for the build status
[06:58:20.241] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:20.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:33:0) after 1m0s
[06:59:20.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:33:0)
[06:59:20.266] Timer tick, asking Buildbucket for the build status
[06:59:20.420] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:34:0) after 1m0s
[07:00:20.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:34:0)
[07:00:20.478] Timer tick, asking Buildbucket for the build status
[07:00:20.897] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:20.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:35:0) after 1m0s
[07:01:20.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:35:0)
[07:01:20.939] Timer tick, asking Buildbucket for the build status
[07:01:21.330] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:21.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:36:0) after 1m0s
[07:02:21.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:36:0)
[07:02:21.399] Timer tick, asking Buildbucket for the build status
[07:02:23.865] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:23.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:37:0) after 1m0s
[07:03:23.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:37:0)
[07:03:23.934] Timer tick, asking Buildbucket for the build status
[07:03:24.564] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:24.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:38:0) after 1m0s
[07:04:24.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:38:0)
[07:04:24.575] Timer tick, asking Buildbucket for the build status
[07:04:27.746] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:27.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:39:0) after 1m0s
[07:05:27.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:39:0)
[07:05:27.901] Timer tick, asking Buildbucket for the build status
[07:05:30.129] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:30.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:40:0) after 1m0s
[07:06:30.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:40:0)
[07:06:30.437] Timer tick, asking Buildbucket for the build status
[07:06:32.982] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:32.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:41:0) after 1m0s
[07:07:33.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:41:0)
[07:07:33.008] Timer tick, asking Buildbucket for the build status
[07:07:33.764] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:33.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:42:0) after 1m0s
[07:08:33.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:42:0)
[07:08:33.911] Timer tick, asking Buildbucket for the build status
[07:08:36.568] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:36.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:43:0) after 1m0s
[07:09:36.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:43:0)
[07:09:36.582] Timer tick, asking Buildbucket for the build status
[07:09:36.725] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:36.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:44:0) after 1m0s
[07:10:36.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:44:0)
[07:10:36.758] Timer tick, asking Buildbucket for the build status
[07:10:37.859] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:37.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:45:0) after 1m0s
[07:11:37.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:45:0)
[07:11:37.889] Timer tick, asking Buildbucket for the build status
[07:11:40.366] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:40.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:46:0) after 1m0s
[07:12:40.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:46:0)
[07:12:40.552] Timer tick, asking Buildbucket for the build status
[07:12:40.860] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:40.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:47:0) after 1m0s
[07:13:41.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:47:0)
[07:13:41.004] Timer tick, asking Buildbucket for the build status
[07:13:41.200] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:48:0) after 1m0s
[07:14:41.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:48:0)
[07:14:41.344] Timer tick, asking Buildbucket for the build status
[07:14:41.898] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:41.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:49:0) after 1m0s
[07:15:42.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:49:0)
[07:15:42.126] Timer tick, asking Buildbucket for the build status
[07:15:42.476] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:42.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:50:0) after 1m0s
[07:16:42.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:50:0)
[07:16:42.777] Timer tick, asking Buildbucket for the build status
[07:16:43.303] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:43.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:51:0) after 1m0s
[07:17:43.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:51:0)
[07:17:43.328] Timer tick, asking Buildbucket for the build status
[07:17:46.241] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:46.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:52:0) after 1m0s
[07:18:46.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:52:0)
[07:18:46.307] Timer tick, asking Buildbucket for the build status
[07:18:46.642] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:53:0) after 1m0s
[07:19:46.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:53:0)
[07:19:46.704] Timer tick, asking Buildbucket for the build status
[07:19:47.034] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:47.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:54:0) after 1m0s
[07:20:47.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:54:0)
[07:20:47.156] Timer tick, asking Buildbucket for the build status
[07:20:50.783] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:50.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:55:0) after 1m0s
[07:21:50.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:55:0)
[07:21:50.843] Timer tick, asking Buildbucket for the build status
[07:21:51.613] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:51.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:56:0) after 1m0s
[07:22:51.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:56:0)
[07:22:51.701] Timer tick, asking Buildbucket for the build status
[07:22:52.587] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:52.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:57:0) after 1m0s
[07:23:52.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:57:0)
[07:23:52.615] Timer tick, asking Buildbucket for the build status
[07:23:53.257] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:53.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:58:0) after 1m0s
[07:24:53.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:58:0)
[07:24:53.305] Timer tick, asking Buildbucket for the build status
[07:24:53.698] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:53.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:59:0) after 1m0s
[07:25:53.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:59:0)
[07:25:53.859] Timer tick, asking Buildbucket for the build status
[07:25:54.683] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:54.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:60:0) after 1m0s
[07:26:54.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:60:0)
[07:26:54.792] Timer tick, asking Buildbucket for the build status
[07:26:55.196] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:55.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:61:0) after 1m0s
[07:27:55.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:61:0)
[07:27:55.290] Timer tick, asking Buildbucket for the build status
[07:27:55.474] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:55.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:62:0) after 1m0s
[07:28:55.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:62:0)
[07:28:55.795] Timer tick, asking Buildbucket for the build status
[07:28:56.044] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:56.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:63:0) after 1m0s
[07:29:56.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:63:0)
[07:29:56.328] Timer tick, asking Buildbucket for the build status
[07:29:56.594] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:56.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:64:0) after 1m0s
[07:30:56.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:64:0)
[07:30:56.798] Timer tick, asking Buildbucket for the build status
[07:30:57.628] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:57.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:65:0) after 1m0s
[07:31:58.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:65:0)
[07:31:58.828] Timer tick, asking Buildbucket for the build status
[07:32:00.511] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:00.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:66:0) after 1m0s
[07:33:00.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:66:0)
[07:33:00.571] Timer tick, asking Buildbucket for the build status
[07:33:00.888] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:00.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:67:0) after 1m0s
[07:34:00.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:67:0)
[07:34:00.922] Timer tick, asking Buildbucket for the build status
[07:34:01.059] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:01.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:68:0) after 1m0s
[07:35:01.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:68:0)
[07:35:01.106] Timer tick, asking Buildbucket for the build status
[07:35:01.435] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:01.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:69:0) after 1m0s
[07:36:01.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:69:0)
[07:36:01.472] Timer tick, asking Buildbucket for the build status
[07:36:02.593] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:02.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:70:0) after 1m0s
[07:37:02.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:70:0)
[07:37:02.624] Timer tick, asking Buildbucket for the build status
[07:37:03.025] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:03.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:71:0) after 1m0s
[07:38:03.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:71:0)
[07:38:03.061] Timer tick, asking Buildbucket for the build status
[07:38:03.298] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:03.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:72:0) after 1m0s
[07:39:03.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:72:0)
[07:39:03.332] Timer tick, asking Buildbucket for the build status
[07:39:04.104] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:04.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:73:0) after 1m0s
[07:40:04.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:73:0)
[07:40:04.199] Timer tick, asking Buildbucket for the build status
[07:40:07.358] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:07.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:74:0) after 1m0s
[07:41:07.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:74:0)
[07:41:07.425] Timer tick, asking Buildbucket for the build status
[07:41:07.928] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:07.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:75:0) after 1m0s
[07:42:07.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:75:0)
[07:42:07.959] Timer tick, asking Buildbucket for the build status
[07:42:08.370] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:76:0) after 1m0s
[07:43:08.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:76:0)
[07:43:08.375] Timer tick, asking Buildbucket for the build status
[07:43:08.612] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:08.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:77:0) after 1m0s
[07:44:08.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:77:0)
[07:44:08.667] Timer tick, asking Buildbucket for the build status
[07:44:09.153] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:09.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:78:0) after 1m0s
[07:45:09.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:78:0)
[07:45:09.199] Timer tick, asking Buildbucket for the build status
[07:45:09.967] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:09.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:79:0) after 1m0s
[07:46:09.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:79:0)
[07:46:09.971] Timer tick, asking Buildbucket for the build status
[07:46:10.515] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:10.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:80:0) after 1m0s
[07:47:10.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:80:0)
[07:47:10.637] Timer tick, asking Buildbucket for the build status
[07:47:13.637] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:13.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:81:0) after 1m0s
[07:48:13.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:81:0)
[07:48:13.682] Timer tick, asking Buildbucket for the build status
[07:48:14.135] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:14.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:82:0) after 1m0s
[07:49:14.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:82:0)
[07:49:14.159] Timer tick, asking Buildbucket for the build status
[07:49:15.547] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:15.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:83:0) after 1m0s
[07:50:15.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:83:0)
[07:50:15.581] Timer tick, asking Buildbucket for the build status
[07:50:16.983] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:16.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:84:0) after 1m0s
[07:51:17.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:84:0)
[07:51:17.018] Timer tick, asking Buildbucket for the build status
[07:51:17.276] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:17.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:85:0) after 1m0s
[07:52:17.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:85:0)
[07:52:17.311] Timer tick, asking Buildbucket for the build status
[07:52:17.795] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:17.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:86:0) after 1m0s
[07:53:17.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:86:0)
[07:53:17.905] Timer tick, asking Buildbucket for the build status
[07:53:20.551] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:20.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:87:0) after 1m0s
[07:54:20.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:87:0)
[07:54:20.654] Timer tick, asking Buildbucket for the build status
[07:54:21.035] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:21.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:88:0) after 1m0s
[07:55:21.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:88:0)
[07:55:21.076] Timer tick, asking Buildbucket for the build status
[07:55:21.489] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:21.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:89:0) after 1m0s
[07:56:21.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:89:0)
[07:56:21.537] Timer tick, asking Buildbucket for the build status
[07:56:25.017] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:25.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:90:0) after 1m0s
[07:57:25.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:90:0)
[07:57:25.042] Timer tick, asking Buildbucket for the build status
[07:57:28.712] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:28.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:91:0) after 1m0s
[07:58:28.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:91:0)
[07:58:28.809] Timer tick, asking Buildbucket for the build status
[07:58:29.647] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:29.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:92:0) after 1m0s
[07:59:29.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:92:0)
[07:59:29.720] Timer tick, asking Buildbucket for the build status
[07:59:33.044] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:33.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:93:0) after 1m0s
[08:00:33.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:93:0)
[08:00:33.189] Timer tick, asking Buildbucket for the build status
[08:00:33.546] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:33.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:94:0) after 1m0s
[08:01:33.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:94:0)
[08:01:33.664] Timer tick, asking Buildbucket for the build status
[08:01:34.063] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:34.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:95:0) after 1m0s
[08:02:34.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:95:0)
[08:02:34.136] Timer tick, asking Buildbucket for the build status
[08:02:37.639] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:37.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:96:0) after 1m0s
[08:03:37.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:96:0)
[08:03:37.751] Timer tick, asking Buildbucket for the build status
[08:03:37.946] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:37.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:97:0) after 1m0s
[08:04:37.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:97:0)
[08:04:37.936] Timer tick, asking Buildbucket for the build status
[08:04:38.604] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:38.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:98:0) after 1m0s
[08:05:38.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:98:0)
[08:05:38.631] Timer tick, asking Buildbucket for the build status
[08:05:40.392] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:40.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:99:0) after 1m0s
[08:06:40.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:99:0)
[08:06:40.430] Timer tick, asking Buildbucket for the build status
[08:06:40.796] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:40.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:100:0) after 1m0s
[08:07:40.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:100:0)
[08:07:40.841] Timer tick, asking Buildbucket for the build status
[08:07:41.324] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:41.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:101:0) after 1m0s
[08:08:41.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:101:0)
[08:08:41.399] Timer tick, asking Buildbucket for the build status
[08:08:42.567] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:42.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:102:0) after 1m0s
[08:09:42.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:102:0)
[08:09:42.593] Timer tick, asking Buildbucket for the build status
[08:09:44.074] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:44.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:103:0) after 1m0s
[08:10:44.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:103:0)
[08:10:44.176] Timer tick, asking Buildbucket for the build status
[08:10:44.476] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:44.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:104:0) after 1m0s
[08:11:44.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:104:0)
[08:11:44.535] Timer tick, asking Buildbucket for the build status
[08:11:48.025] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:48.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:105:0) after 1m0s
[08:12:48.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:105:0)
[08:12:48.052] Timer tick, asking Buildbucket for the build status
[08:12:48.434] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:48.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:106:0) after 1m0s
[08:13:48.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:106:0)
[08:13:48.458] Timer tick, asking Buildbucket for the build status
[08:13:48.654] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:107:0) after 1m0s
[08:14:48.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:107:0)
[08:14:48.697] Timer tick, asking Buildbucket for the build status
[08:14:49.263] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:49.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:108:0) after 1m0s
[08:15:49.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:108:0)
[08:15:49.538] Timer tick, asking Buildbucket for the build status
[08:15:51.494] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:51.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:109:0) after 1m0s
[08:16:51.521] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:109:0)
[08:16:51.521] Timer tick, asking Buildbucket for the build status
[08:16:52.378] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:52.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:110:0) after 1m0s
[08:17:52.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:110:0)
[08:17:52.437] Timer tick, asking Buildbucket for the build status
[08:17:52.812] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:52.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:111:0) after 1m0s
[08:18:52.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:111:0)
[08:18:52.892] Timer tick, asking Buildbucket for the build status
[08:18:54.291] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:54.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:112:0) after 1m0s
[08:19:54.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:112:0)
[08:19:54.318] Timer tick, asking Buildbucket for the build status
[08:19:54.978] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:54.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:113:0) after 1m0s
[08:20:55.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:113:0)
[08:20:55.008] Timer tick, asking Buildbucket for the build status
[08:20:55.963] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:55.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:114:0) after 1m0s
[08:21:56.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:114:0)
[08:21:56.013] Timer tick, asking Buildbucket for the build status
[08:21:59.169] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:59.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:115:0) after 1m0s
[08:22:59.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:115:0)
[08:22:59.198] Timer tick, asking Buildbucket for the build status
[08:22:59.451] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:59.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:116:0) after 1m0s
[08:23:59.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:116:0)
[08:23:59.482] Timer tick, asking Buildbucket for the build status
[08:23:59.717] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:59.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:117:0) after 1m0s
[08:24:59.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:117:0)
[08:24:59.759] Timer tick, asking Buildbucket for the build status
[08:25:00.047] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:00.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:118:0) after 1m0s
[08:26:00.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:118:0)
[08:26:00.141] Timer tick, asking Buildbucket for the build status
[08:26:00.524] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:00.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:119:0) after 1m0s
[08:27:00.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:119:0)
[08:27:00.550] Timer tick, asking Buildbucket for the build status
[08:27:00.769] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:00.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:120:0) after 1m0s
[08:28:00.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:120:0)
[08:28:00.803] Timer tick, asking Buildbucket for the build status
[08:28:01.076] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:01.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:121:0) after 1m0s
[08:29:01.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:121:0)
[08:29:01.107] Timer tick, asking Buildbucket for the build status
[08:29:01.311] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:01.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:122:0) after 1m0s
[08:30:01.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:122:0)
[08:30:01.734] Timer tick, asking Buildbucket for the build status
[08:30:03.431] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:03.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:123:0) after 1m0s
[08:31:03.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:123:0)
[08:31:03.783] Timer tick, asking Buildbucket for the build status
[08:31:05.083] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:05.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:124:0) after 1m0s
[08:32:05.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:124:0)
[08:32:05.195] Timer tick, asking Buildbucket for the build status
[08:32:05.689] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:05.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:125:0) after 1m0s
[08:33:06.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:125:0)
[08:33:06.076] Timer tick, asking Buildbucket for the build status
[08:33:09.116] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:09.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:126:0) after 1m0s
[08:34:09.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:126:0)
[08:34:09.206] Timer tick, asking Buildbucket for the build status
[08:34:10.965] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:10.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:127:0) after 1m0s
[08:35:10.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:127:0)
[08:35:10.998] Timer tick, asking Buildbucket for the build status
[08:35:12.808] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:12.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:128:0) after 1m0s
[08:36:12.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:128:0)
[08:36:12.942] Timer tick, asking Buildbucket for the build status
[08:36:14.575] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:14.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:129:0) after 1m0s
[08:37:14.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:129:0)
[08:37:14.670] Timer tick, asking Buildbucket for the build status
[08:37:16.460] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:16.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:130:0) after 1m0s
[08:38:16.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:130:0)
[08:38:16.529] Timer tick, asking Buildbucket for the build status
[08:38:16.737] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:16.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:131:0) after 1m0s
[08:39:16.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:131:0)
[08:39:16.860] Timer tick, asking Buildbucket for the build status
[08:39:17.182] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:17.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:132:0) after 1m0s
[08:40:17.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:132:0)
[08:40:17.207] Timer tick, asking Buildbucket for the build status
[08:40:17.536] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:17.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:133:0) after 1m0s
[08:41:17.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:133:0)
[08:41:17.578] Timer tick, asking Buildbucket for the build status
[08:41:18.297] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:18.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:134:0) after 1m0s
[08:42:18.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:134:0)
[08:42:18.454] Timer tick, asking Buildbucket for the build status
[08:42:18.874] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:18.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:135:0) after 1m0s
[08:43:18.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:135:0)
[08:43:18.917] Timer tick, asking Buildbucket for the build status
[08:43:19.179] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:19.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:136:0) after 1m0s
[08:44:19.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:136:0)
[08:44:19.203] Timer tick, asking Buildbucket for the build status
[08:44:19.474] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:19.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:137:0) after 1m0s
[08:45:19.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:137:0)
[08:45:19.502] Timer tick, asking Buildbucket for the build status
[08:45:22.674] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:22.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:138:0) after 1m0s
[08:46:22.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:138:0)
[08:46:22.834] Timer tick, asking Buildbucket for the build status
[08:46:24.133] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:24.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:139:0) after 1m0s
[08:47:24.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:139:0)
[08:47:24.219] Timer tick, asking Buildbucket for the build status
[08:47:24.457] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:24.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:140:0) after 1m0s
[08:48:24.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:140:0)
[08:48:24.646] Timer tick, asking Buildbucket for the build status
[08:48:24.850] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:24.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:141:0) after 1m0s
[08:49:24.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:141:0)
[08:49:24.889] Timer tick, asking Buildbucket for the build status
[08:49:29.710] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:29.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:142:0) after 1m0s
[08:50:29.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:142:0)
[08:50:29.788] Timer tick, asking Buildbucket for the build status
[08:50:30.086] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:30.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:143:0) after 1m0s
[08:51:30.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:143:0)
[08:51:30.169] Timer tick, asking Buildbucket for the build status
[08:51:37.164] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:37.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:144:0) after 1m0s
[08:52:37.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:144:0)
[08:52:37.216] Timer tick, asking Buildbucket for the build status
[08:52:37.581] Build 8903359157654659360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:37.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068789219809555312:145:0) after 1m0s
[08:53:02.820] Received PubSub notification, asking Buildbucket for the build status
[08:53:06.163] Build 8903359157654659360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:53:06.163] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567500781954399",
"created_by": "project:chromium",
"created_ts": "1567492063812860",
"id": "8903359157654659360",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f4952ec921e83c1399dbcef76774ded442cd948e\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-bzrg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14613, \"got_angle_revision\": \"a3c7c2ff6a90a864751bdcd023979a32fae2bda7\", \"got_dawn_revision\": \"179d7b28a36a5c042f16857ac7a45466c519b536\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"f4952ec921e83c1399dbcef76774ded442cd948e\", \"got_revision_cp\": \"refs/heads/master@{#692559}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"b2ea4d05947ae3eaa20c1fa9c53f8565cbc1d3b9\", \"got_v8_revision_cp\": \"refs/heads/7.8.251@{#1}\", \"got_webrtc_revision\": \"a77a1f910ba33f89041a344d6962d2e3bb6cda20\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29041}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f4952ec921e83c1399dbcef76774ded442cd948e\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-bzrg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567492067016002",
"status": "COMPLETED",
"status_changed_ts": "1567500782335307",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14613",
"builder:Windows deterministic",
"buildset:commit/git/f4952ec921e83c1399dbcef76774ded442cd948e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f4952ec921e83c1399dbcef76774ded442cd948e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068789219809555312",
"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/8903359157654659360/+/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:470ea04e4adac510",
"user_agent:luci-scheduler"
],
"updated_ts": "1567500782338706",
"url": "https://ci.chromium.org/b/8903359157654659360",
"utcnow_ts": "1567500785983847"
}
}
[08:53:06.163] Invocation finished in 2h25m23.790130346s with status SUCCEEDED