[08:25:04.214] New invocation is queued and will start shortly
[08:25:05.352] Starting the invocation (attempt 1)
[08:25:05.388] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:25:05.388] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:25:05.388] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083820932343931376",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"889b205289cfc23af66c7563abf377b29bfce427\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9083820932343931376",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/889b205289cfc23af66c7563abf377b29bfce427",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/889b205289cfc23af66c7563abf377b29bfce427",
"gitiles_ref:refs/heads/master"
]
}
[08:25:06.525] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553156705524821",
"id": "8918390870306233296",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"889b205289cfc23af66c7563abf377b29bfce427\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553156706326396",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12515",
"builder:Windows deterministic",
"buildset:commit/git/889b205289cfc23af66c7563abf377b29bfce427",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/889b205289cfc23af66c7563abf377b29bfce427",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083820932343931376",
"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/8918390870306233296/+/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:43b82c163dcaf210",
"user_agent:luci-scheduler"
],
"updated_ts": "1553156706326466",
"url": "https://ci.chromium.org/b/8918390870306233296",
"utcnow_ts": "1553156706516623"
}
}
[08:25:06.525] Task URL: https://ci.chromium.org/b/8918390870306233296
[08:25:06.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:2:0) after 1m0s
[08:25:08.685] Received PubSub notification, asking Buildbucket for the build status
[08:25:09.215] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:06.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:2:0)
[08:26:06.557] Timer tick, asking Buildbucket for the build status
[08:26:06.720] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:06.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:4:0) after 1m0s
[08:27:06.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:4:0)
[08:27:06.731] Timer tick, asking Buildbucket for the build status
[08:27:07.306] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:07.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:5:0) after 1m0s
[08:28:07.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:5:0)
[08:28:07.276] Timer tick, asking Buildbucket for the build status
[08:28:07.397] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:07.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:6:0) after 1m0s
[08:29:07.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:6:0)
[08:29:07.407] Timer tick, asking Buildbucket for the build status
[08:29:07.520] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:07.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:7:0) after 1m0s
[08:30:07.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:7:0)
[08:30:07.554] Timer tick, asking Buildbucket for the build status
[08:30:07.659] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:07.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:8:0) after 1m0s
[08:31:07.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:8:0)
[08:31:07.681] Timer tick, asking Buildbucket for the build status
[08:31:08.054] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:08.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:9:0) after 1m0s
[08:32:08.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:9:0)
[08:32:08.044] Timer tick, asking Buildbucket for the build status
[08:32:08.176] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:08.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:10:0) after 1m0s
[08:33:08.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:10:0)
[08:33:08.207] Timer tick, asking Buildbucket for the build status
[08:33:08.342] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:08.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:11:0) after 1m0s
[08:34:08.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:11:0)
[08:34:08.364] Timer tick, asking Buildbucket for the build status
[08:34:08.503] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:08.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:12:0) after 1m0s
[08:35:08.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:12:0)
[08:35:08.487] Timer tick, asking Buildbucket for the build status
[08:35:08.631] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:08.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:13:0) after 1m0s
[08:36:08.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:13:0)
[08:36:08.645] Timer tick, asking Buildbucket for the build status
[08:36:08.857] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:08.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:14:0) after 1m0s
[08:37:08.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:14:0)
[08:37:08.873] Timer tick, asking Buildbucket for the build status
[08:37:09.002] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:09.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:15:0) after 1m0s
[08:38:08.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:15:0)
[08:38:08.996] Timer tick, asking Buildbucket for the build status
[08:38:09.110] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:09.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:16:0) after 1m0s
[08:39:09.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:16:0)
[08:39:09.111] Timer tick, asking Buildbucket for the build status
[08:39:09.481] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:09.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:17:0) after 1m0s
[08:40:09.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:17:0)
[08:40:09.488] Timer tick, asking Buildbucket for the build status
[08:40:10.343] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:10.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:18:0) after 1m0s
[08:41:10.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:18:0)
[08:41:10.368] Timer tick, asking Buildbucket for the build status
[08:41:11.021] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:11.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:19:0) after 1m0s
[08:42:11.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:19:0)
[08:42:11.031] Timer tick, asking Buildbucket for the build status
[08:42:11.310] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:11.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:20:0) after 1m0s
[08:43:11.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:20:0)
[08:43:11.421] Timer tick, asking Buildbucket for the build status
[08:43:11.532] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:11.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:21:0) after 1m0s
[08:44:11.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:21:0)
[08:44:11.508] Timer tick, asking Buildbucket for the build status
[08:44:11.677] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:11.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:22:0) after 1m0s
[08:45:11.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:22:0)
[08:45:11.686] Timer tick, asking Buildbucket for the build status
[08:45:11.804] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:11.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:23:0) after 1m0s
[08:46:11.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:23:0)
[08:46:11.778] Timer tick, asking Buildbucket for the build status
[08:46:11.891] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:11.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:24:0) after 1m0s
[08:47:11.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:24:0)
[08:47:11.936] Timer tick, asking Buildbucket for the build status
[08:47:12.195] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:12.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:25:0) after 1m0s
[08:48:12.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:25:0)
[08:48:12.189] Timer tick, asking Buildbucket for the build status
[08:48:12.703] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:12.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:26:0) after 1m0s
[08:49:12.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:26:0)
[08:49:12.674] Timer tick, asking Buildbucket for the build status
[08:49:13.102] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:13.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:27:0) after 1m0s
[08:50:13.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:27:0)
[08:50:13.106] Timer tick, asking Buildbucket for the build status
[08:50:13.276] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:13.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:28:0) after 1m0s
[08:51:13.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:28:0)
[08:51:13.281] Timer tick, asking Buildbucket for the build status
[08:51:13.808] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:13.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:29:0) after 1m0s
[08:52:13.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:29:0)
[08:52:13.781] Timer tick, asking Buildbucket for the build status
[08:52:13.961] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:13.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:30:0) after 1m0s
[08:53:14.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:30:0)
[08:53:14.069] Timer tick, asking Buildbucket for the build status
[08:53:15.006] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:15.006] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:31:0) after 1m0s
[08:54:15.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:31:0)
[08:54:15.004] Timer tick, asking Buildbucket for the build status
[08:54:15.123] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:15.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:32:0) after 1m0s
[08:55:15.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:32:0)
[08:55:15.132] Timer tick, asking Buildbucket for the build status
[08:55:15.244] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:15.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:33:0) after 1m0s
[08:56:15.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:33:0)
[08:56:15.266] Timer tick, asking Buildbucket for the build status
[08:56:15.525] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:15.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:34:0) after 1m0s
[08:57:15.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:34:0)
[08:57:15.531] Timer tick, asking Buildbucket for the build status
[08:57:15.876] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:15.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:35:0) after 1m0s
[08:58:15.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:35:0)
[08:58:15.891] Timer tick, asking Buildbucket for the build status
[08:58:16.271] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:16.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:36:0) after 1m0s
[08:59:16.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:36:0)
[08:59:16.307] Timer tick, asking Buildbucket for the build status
[08:59:16.682] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:16.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:37:0) after 1m0s
[09:00:16.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:37:0)
[09:00:16.671] Timer tick, asking Buildbucket for the build status
[09:00:17.307] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:17.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:38:0) after 1m0s
[09:01:17.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:38:0)
[09:01:17.328] Timer tick, asking Buildbucket for the build status
[09:01:17.486] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:17.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:39:0) after 1m0s
[09:02:17.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:39:0)
[09:02:17.497] Timer tick, asking Buildbucket for the build status
[09:02:17.932] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:17.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:40:0) after 1m0s
[09:03:17.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:40:0)
[09:03:17.952] Timer tick, asking Buildbucket for the build status
[09:03:18.332] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:18.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:41:0) after 1m0s
[09:04:18.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:41:0)
[09:04:18.335] Timer tick, asking Buildbucket for the build status
[09:04:18.910] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:42:0) after 1m0s
[09:05:18.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:42:0)
[09:05:18.932] Timer tick, asking Buildbucket for the build status
[09:05:19.287] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:19.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:43:0) after 1m0s
[09:06:19.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:43:0)
[09:06:19.278] Timer tick, asking Buildbucket for the build status
[09:06:19.395] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:19.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:44:0) after 1m0s
[09:07:19.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:44:0)
[09:07:19.371] Timer tick, asking Buildbucket for the build status
[09:07:19.527] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:19.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:45:0) after 1m0s
[09:08:19.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:45:0)
[09:08:19.583] Timer tick, asking Buildbucket for the build status
[09:08:20.519] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:20.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:46:0) after 1m0s
[09:09:20.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:46:0)
[09:09:20.542] Timer tick, asking Buildbucket for the build status
[09:09:20.655] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:20.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:47:0) after 1m0s
[09:10:20.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:47:0)
[09:10:20.678] Timer tick, asking Buildbucket for the build status
[09:10:20.781] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:20.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:48:0) after 1m0s
[09:11:20.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:48:0)
[09:11:20.801] Timer tick, asking Buildbucket for the build status
[09:11:20.947] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:20.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:49:0) after 1m0s
[09:12:20.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:49:0)
[09:12:20.966] Timer tick, asking Buildbucket for the build status
[09:12:21.254] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:21.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:50:0) after 1m0s
[09:13:21.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:50:0)
[09:13:21.273] Timer tick, asking Buildbucket for the build status
[09:13:21.575] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:21.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:51:0) after 1m0s
[09:14:21.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:51:0)
[09:14:21.596] Timer tick, asking Buildbucket for the build status
[09:14:21.885] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:21.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:52:0) after 1m0s
[09:15:21.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:52:0)
[09:15:21.897] Timer tick, asking Buildbucket for the build status
[09:15:22.399] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:22.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:53:0) after 1m0s
[09:16:22.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:53:0)
[09:16:22.397] Timer tick, asking Buildbucket for the build status
[09:16:22.497] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:22.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:54:0) after 1m0s
[09:17:22.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:54:0)
[09:17:22.504] Timer tick, asking Buildbucket for the build status
[09:17:22.607] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:22.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:55:0) after 1m0s
[09:18:22.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:55:0)
[09:18:22.612] Timer tick, asking Buildbucket for the build status
[09:18:22.703] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:22.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:56:0) after 1m0s
[09:19:22.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:56:0)
[09:19:22.723] Timer tick, asking Buildbucket for the build status
[09:19:23.160] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:23.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:57:0) after 1m0s
[09:20:23.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:57:0)
[09:20:23.182] Timer tick, asking Buildbucket for the build status
[09:20:23.268] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:23.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:58:0) after 1m0s
[09:21:23.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:58:0)
[09:21:23.258] Timer tick, asking Buildbucket for the build status
[09:21:23.748] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:23.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:59:0) after 1m0s
[09:22:23.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:59:0)
[09:22:23.788] Timer tick, asking Buildbucket for the build status
[09:22:24.074] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:60:0) after 1m0s
[09:23:24.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:60:0)
[09:23:24.096] Timer tick, asking Buildbucket for the build status
[09:23:24.229] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:24.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:61:0) after 1m0s
[09:24:24.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:61:0)
[09:24:24.238] Timer tick, asking Buildbucket for the build status
[09:24:24.867] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:24.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:62:0) after 1m0s
[09:25:24.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:62:0)
[09:25:24.886] Timer tick, asking Buildbucket for the build status
[09:25:25.135] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:25.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:63:0) after 1m0s
[09:26:25.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:63:0)
[09:26:25.156] Timer tick, asking Buildbucket for the build status
[09:26:25.684] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:25.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:64:0) after 1m0s
[09:27:25.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:64:0)
[09:27:25.692] Timer tick, asking Buildbucket for the build status
[09:27:25.839] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:25.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:65:0) after 1m0s
[09:28:25.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:65:0)
[09:28:25.823] Timer tick, asking Buildbucket for the build status
[09:28:26.024] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:26.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:66:0) after 1m0s
[09:29:26.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:66:0)
[09:29:26.034] Timer tick, asking Buildbucket for the build status
[09:29:26.488] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:26.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:67:0) after 1m0s
[09:30:26.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:67:0)
[09:30:26.492] Timer tick, asking Buildbucket for the build status
[09:30:26.688] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:26.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:68:0) after 1m0s
[09:31:26.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:68:0)
[09:31:26.664] Timer tick, asking Buildbucket for the build status
[09:31:26.919] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:26.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:69:0) after 1m0s
[09:32:26.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:69:0)
[09:32:26.940] Timer tick, asking Buildbucket for the build status
[09:32:27.277] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:27.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:70:0) after 1m0s
[09:33:27.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:70:0)
[09:33:27.299] Timer tick, asking Buildbucket for the build status
[09:33:28.076] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:28.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:71:0) after 1m0s
[09:34:28.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:71:0)
[09:34:28.054] Timer tick, asking Buildbucket for the build status
[09:34:29.402] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:29.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:72:0) after 1m0s
[09:35:29.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:72:0)
[09:35:29.415] Timer tick, asking Buildbucket for the build status
[09:35:32.428] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:32.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:73:0) after 1m0s
[09:36:32.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:73:0)
[09:36:32.413] Timer tick, asking Buildbucket for the build status
[09:36:32.511] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:32.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:74:0) after 1m0s
[09:37:32.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:74:0)
[09:37:32.523] Timer tick, asking Buildbucket for the build status
[09:37:32.845] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:75:0) after 1m0s
[09:38:32.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:75:0)
[09:38:32.852] Timer tick, asking Buildbucket for the build status
[09:38:32.955] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:32.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:76:0) after 1m0s
[09:39:32.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:76:0)
[09:39:32.946] Timer tick, asking Buildbucket for the build status
[09:39:33.458] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:33.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:77:0) after 1m0s
[09:40:33.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:77:0)
[09:40:33.462] Timer tick, asking Buildbucket for the build status
[09:40:33.794] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:33.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:78:0) after 1m0s
[09:41:33.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:78:0)
[09:41:33.850] Timer tick, asking Buildbucket for the build status
[09:41:33.999] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:33.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:79:0) after 1m0s
[09:42:34.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:79:0)
[09:42:34.000] Timer tick, asking Buildbucket for the build status
[09:42:34.417] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:34.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:80:0) after 1m0s
[09:43:34.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:80:0)
[09:43:34.461] Timer tick, asking Buildbucket for the build status
[09:43:34.570] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:34.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:81:0) after 1m0s
[09:44:34.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:81:0)
[09:44:34.590] Timer tick, asking Buildbucket for the build status
[09:44:34.890] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:34.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:82:0) after 1m0s
[09:45:34.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:82:0)
[09:45:34.913] Timer tick, asking Buildbucket for the build status
[09:45:35.625] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:35.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:83:0) after 1m0s
[09:46:35.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:83:0)
[09:46:35.648] Timer tick, asking Buildbucket for the build status
[09:46:36.106] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:36.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:84:0) after 1m0s
[09:47:36.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:84:0)
[09:47:36.100] Timer tick, asking Buildbucket for the build status
[09:47:36.274] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:36.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:85:0) after 1m0s
[09:48:36.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:85:0)
[09:48:36.359] Timer tick, asking Buildbucket for the build status
[09:48:38.218] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:38.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:86:0) after 1m0s
[09:49:38.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:86:0)
[09:49:38.197] Timer tick, asking Buildbucket for the build status
[09:49:38.471] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:38.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:87:0) after 1m0s
[09:50:38.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:87:0)
[09:50:38.497] Timer tick, asking Buildbucket for the build status
[09:50:38.812] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:38.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:88:0) after 1m0s
[09:51:38.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:88:0)
[09:51:38.833] Timer tick, asking Buildbucket for the build status
[09:51:38.950] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:38.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:89:0) after 1m0s
[09:52:38.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:89:0)
[09:52:38.972] Timer tick, asking Buildbucket for the build status
[09:52:39.112] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:39.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:90:0) after 1m0s
[09:53:39.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:90:0)
[09:53:39.132] Timer tick, asking Buildbucket for the build status
[09:53:39.314] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:39.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:91:0) after 1m0s
[09:54:39.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:91:0)
[09:54:39.316] Timer tick, asking Buildbucket for the build status
[09:54:39.983] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:92:0) after 1m0s
[09:55:40.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:92:0)
[09:55:40.015] Timer tick, asking Buildbucket for the build status
[09:55:40.737] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:40.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:93:0) after 1m0s
[09:56:40.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:93:0)
[09:56:40.759] Timer tick, asking Buildbucket for the build status
[09:56:41.025] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:41.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:94:0) after 1m0s
[09:57:41.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:94:0)
[09:57:41.048] Timer tick, asking Buildbucket for the build status
[09:57:41.781] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:41.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:95:0) after 1m0s
[09:58:41.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:95:0)
[09:58:41.785] Timer tick, asking Buildbucket for the build status
[09:58:42.510] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:42.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:96:0) after 1m0s
[09:59:42.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:96:0)
[09:59:42.537] Timer tick, asking Buildbucket for the build status
[09:59:43.090] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:43.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:97:0) after 1m0s
[10:00:43.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:97:0)
[10:00:43.128] Timer tick, asking Buildbucket for the build status
[10:00:43.331] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:43.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:98:0) after 1m0s
[10:01:43.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:98:0)
[10:01:43.352] Timer tick, asking Buildbucket for the build status
[10:01:43.600] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:43.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:99:0) after 1m0s
[10:02:43.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:99:0)
[10:02:43.624] Timer tick, asking Buildbucket for the build status
[10:02:43.981] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:43.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:100:0) after 1m0s
[10:03:44.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:100:0)
[10:03:44.019] Timer tick, asking Buildbucket for the build status
[10:03:44.162] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:44.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:101:0) after 1m0s
[10:04:44.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:101:0)
[10:04:44.184] Timer tick, asking Buildbucket for the build status
[10:04:44.338] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:44.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:102:0) after 1m0s
[10:05:44.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:102:0)
[10:05:44.359] Timer tick, asking Buildbucket for the build status
[10:05:44.783] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:44.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:103:0) after 1m0s
[10:06:44.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:103:0)
[10:06:44.830] Timer tick, asking Buildbucket for the build status
[10:06:45.153] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:45.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:104:0) after 1m0s
[10:07:45.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:104:0)
[10:07:45.174] Timer tick, asking Buildbucket for the build status
[10:07:45.508] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:45.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:105:0) after 1m0s
[10:08:45.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:105:0)
[10:08:45.530] Timer tick, asking Buildbucket for the build status
[10:08:45.619] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:45.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:106:0) after 1m0s
[10:09:45.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:106:0)
[10:09:45.623] Timer tick, asking Buildbucket for the build status
[10:09:47.733] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:47.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:107:0) after 1m0s
[10:10:47.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:107:0)
[10:10:47.748] Timer tick, asking Buildbucket for the build status
[10:10:48.086] Build 8918390870306233296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:48.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9083820932343931376:108:0) after 1m0s
[10:11:17.889] Received PubSub notification, asking Buildbucket for the build status
[10:11:18.087] Build 8918390870306233296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:11:18.087] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553163077103433",
"created_by": "project:chromium",
"created_ts": "1553156705524821",
"id": "8918390870306233296",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"889b205289cfc23af66c7563abf377b29bfce427\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"id\": [\"windows-deterministic-0-v3qq\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4211-90dafba\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_angle_revision\": \"232bfeae6b292ac4286348a430c4cef78edcf7c0\", \"got_nacl_revision\": \"7d24fb15d81f95ed30dde0c04b68584749709657\", \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_revision_cp\": \"refs/heads/master@{#642855}\", \"got_webrtc_revision\": \"f7f9845d9e5b24c73a70fceb278a20b43e9d9919\", \"got_revision\": \"889b205289cfc23af66c7563abf377b29bfce427\", \"buildername\": \"Windows deterministic\", \"recipe\": \"swarming/deterministic_build\", \"mastername\": \"chromium.win\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"got_v8_revision\": \"da7a3d8e0374cb531d9ce0a3215650eccdd9a8f0\", \"got_v8_revision_cp\": \"refs/heads/7.5.75@{#2}\", \"got_dawn_revision\": \"54e4d47db4910ebd1ffce0247b60d4e6f984774f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27211}\", \"buildnumber\": 12515, \"path_config\": \"generic\", \"revision\": \"889b205289cfc23af66c7563abf377b29bfce427\", \"bot_id\": \"windows-deterministic-0-v3qq\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553156707962540",
"status": "COMPLETED",
"status_changed_ts": "1553163077666089",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/12515",
"builder:Windows deterministic",
"buildset:commit/git/889b205289cfc23af66c7563abf377b29bfce427",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/889b205289cfc23af66c7563abf377b29bfce427",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083820932343931376",
"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/8918390870306233296/+/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:43b82c163dcaf210",
"user_agent:luci-scheduler"
],
"updated_ts": "1553163077669770",
"url": "https://ci.chromium.org/b/8918390870306233296",
"utcnow_ts": "1553163078072778"
}
}
[10:11:18.087] Invocation finished in 1h46m13.889471961s with status SUCCEEDED