[01:34:36.306] New invocation is queued and will start shortly
[01:34:37.377] Starting the invocation (attempt 1)
[01:34:37.418] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:34:37.418] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:34:37.418] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9080041683986885120",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"0c2efc3c0040591113be07196f8389ae295171b8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9080041683986885120",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/0c2efc3c0040591113be07196f8389ae295171b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c2efc3c0040591113be07196f8389ae295171b8",
"gitiles_ref:refs/heads/master"
]
}
[01:34:39.364] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1556760877618853",
"id": "8914611621949011392",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0c2efc3c0040591113be07196f8389ae295171b8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1556760879187593",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/13168",
"builder:Windows deterministic",
"buildset:commit/git/0c2efc3c0040591113be07196f8389ae295171b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c2efc3c0040591113be07196f8389ae295171b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080041683986885120",
"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/8914611621949011392/+/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": "1556760879187763",
"url": "https://ci.chromium.org/b/8914611621949011392",
"utcnow_ts": "1556760879351134"
}
}
[01:34:39.364] Task URL: https://ci.chromium.org/b/8914611621949011392
[01:34:39.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:2:0) after 1m0s
[01:34:43.262] Received PubSub notification, asking Buildbucket for the build status
[01:34:43.793] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:39.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:2:0)
[01:35:39.385] Timer tick, asking Buildbucket for the build status
[01:35:40.541] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:40.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:4:0) after 1m0s
[01:36:40.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:4:0)
[01:36:40.596] Timer tick, asking Buildbucket for the build status
[01:36:41.173] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:41.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:5:0) after 1m0s
[01:37:41.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:5:0)
[01:37:41.194] Timer tick, asking Buildbucket for the build status
[01:37:41.622] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:41.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:6:0) after 1m0s
[01:38:41.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:6:0)
[01:38:41.613] Timer tick, asking Buildbucket for the build status
[01:38:41.710] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:41.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:7:0) after 1m0s
[01:39:41.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:7:0)
[01:39:41.730] Timer tick, asking Buildbucket for the build status
[01:39:42.089] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:42.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:8:0) after 1m0s
[01:40:42.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:8:0)
[01:40:42.062] Timer tick, asking Buildbucket for the build status
[01:40:43.016] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:43.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:9:0) after 1m0s
[01:41:43.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:9:0)
[01:41:43.021] Timer tick, asking Buildbucket for the build status
[01:41:43.161] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:43.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:10:0) after 1m0s
[01:42:43.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:10:0)
[01:42:43.153] Timer tick, asking Buildbucket for the build status
[01:42:43.521] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:43.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:11:0) after 1m0s
[01:43:43.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:11:0)
[01:43:43.542] Timer tick, asking Buildbucket for the build status
[01:43:44.080] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:44.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:12:0) after 1m0s
[01:44:44.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:12:0)
[01:44:44.096] Timer tick, asking Buildbucket for the build status
[01:44:44.608] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:44.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:13:0) after 1m0s
[01:45:44.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:13:0)
[01:45:44.642] Timer tick, asking Buildbucket for the build status
[01:45:45.115] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:45.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:14:0) after 1m0s
[01:46:45.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:14:0)
[01:46:45.137] Timer tick, asking Buildbucket for the build status
[01:46:45.944] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:45.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:15:0) after 1m0s
[01:47:45.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:15:0)
[01:47:45.977] Timer tick, asking Buildbucket for the build status
[01:47:47.315] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:47.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:16:0) after 1m0s
[01:48:47.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:16:0)
[01:48:47.339] Timer tick, asking Buildbucket for the build status
[01:48:47.640] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:47.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:17:0) after 1m0s
[01:49:47.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:17:0)
[01:49:47.631] Timer tick, asking Buildbucket for the build status
[01:49:48.010] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:48.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:18:0) after 1m0s
[01:50:48.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:18:0)
[01:50:48.054] Timer tick, asking Buildbucket for the build status
[01:50:48.193] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:48.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:19:0) after 1m0s
[01:51:48.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:19:0)
[01:51:48.194] Timer tick, asking Buildbucket for the build status
[01:51:48.327] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:48.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:20:0) after 1m0s
[01:52:48.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:20:0)
[01:52:48.322] Timer tick, asking Buildbucket for the build status
[01:52:48.747] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:48.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:21:0) after 1m0s
[01:53:48.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:21:0)
[01:53:48.775] Timer tick, asking Buildbucket for the build status
[01:53:49.078] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:49.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:22:0) after 1m0s
[01:54:49.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:22:0)
[01:54:49.086] Timer tick, asking Buildbucket for the build status
[01:54:49.516] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:49.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:23:0) after 1m0s
[01:55:49.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:23:0)
[01:55:49.561] Timer tick, asking Buildbucket for the build status
[01:55:50.075] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:50.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:24:0) after 1m0s
[01:56:50.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:24:0)
[01:56:50.100] Timer tick, asking Buildbucket for the build status
[01:56:51.834] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:51.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:25:0) after 1m0s
[01:57:51.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:25:0)
[01:57:51.860] Timer tick, asking Buildbucket for the build status
[01:57:52.467] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:52.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:26:0) after 1m0s
[01:58:52.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:26:0)
[01:58:52.478] Timer tick, asking Buildbucket for the build status
[01:58:52.736] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:52.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:27:0) after 1m0s
[01:59:52.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:27:0)
[01:59:52.712] Timer tick, asking Buildbucket for the build status
[01:59:52.815] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:52.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:28:0) after 1m0s
[02:00:52.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:28:0)
[02:00:52.818] Timer tick, asking Buildbucket for the build status
[02:00:52.947] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:52.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:29:0) after 1m0s
[02:01:52.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:29:0)
[02:01:52.941] Timer tick, asking Buildbucket for the build status
[02:01:54.002] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:54.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:30:0) after 1m0s
[02:02:54.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:30:0)
[02:02:54.031] Timer tick, asking Buildbucket for the build status
[02:02:54.714] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:54.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:31:0) after 1m0s
[02:03:54.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:31:0)
[02:03:54.715] Timer tick, asking Buildbucket for the build status
[02:03:54.848] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:54.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:32:0) after 1m0s
[02:04:54.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:32:0)
[02:04:54.871] Timer tick, asking Buildbucket for the build status
[02:04:55.609] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:55.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:33:0) after 1m0s
[02:05:55.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:33:0)
[02:05:55.633] Timer tick, asking Buildbucket for the build status
[02:05:56.280] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:56.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:34:0) after 1m0s
[02:06:56.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:34:0)
[02:06:56.289] Timer tick, asking Buildbucket for the build status
[02:06:56.790] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:56.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:35:0) after 1m0s
[02:07:56.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:35:0)
[02:07:56.778] Timer tick, asking Buildbucket for the build status
[02:07:56.922] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:56.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:36:0) after 1m0s
[02:08:56.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:36:0)
[02:08:56.894] Timer tick, asking Buildbucket for the build status
[02:08:57.588] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:57.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:37:0) after 1m0s
[02:09:57.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:37:0)
[02:09:57.563] Timer tick, asking Buildbucket for the build status
[02:09:58.348] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:58.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:38:0) after 1m0s
[02:10:58.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:38:0)
[02:10:58.369] Timer tick, asking Buildbucket for the build status
[02:10:58.669] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:58.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:39:0) after 1m0s
[02:11:58.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:39:0)
[02:11:58.690] Timer tick, asking Buildbucket for the build status
[02:11:58.820] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:58.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:40:0) after 1m0s
[02:12:58.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:40:0)
[02:12:58.857] Timer tick, asking Buildbucket for the build status
[02:12:59.061] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:59.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:41:0) after 1m0s
[02:13:59.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:41:0)
[02:13:59.083] Timer tick, asking Buildbucket for the build status
[02:13:59.401] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:59.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:42:0) after 1m0s
[02:14:59.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:42:0)
[02:14:59.429] Timer tick, asking Buildbucket for the build status
[02:14:59.591] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:59.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:43:0) after 1m0s
[02:15:59.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:43:0)
[02:15:59.602] Timer tick, asking Buildbucket for the build status
[02:16:00.752] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:00.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:44:0) after 1m0s
[02:17:00.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:44:0)
[02:17:00.772] Timer tick, asking Buildbucket for the build status
[02:17:01.192] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:01.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:45:0) after 1m0s
[02:18:01.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:45:0)
[02:18:01.201] Timer tick, asking Buildbucket for the build status
[02:18:01.446] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:01.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:46:0) after 1m0s
[02:19:01.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:46:0)
[02:19:01.472] Timer tick, asking Buildbucket for the build status
[02:19:01.976] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:01.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:47:0) after 1m0s
[02:20:02.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:47:0)
[02:20:02.018] Timer tick, asking Buildbucket for the build status
[02:20:02.412] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:02.412] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:48:0) after 1m0s
[02:21:02.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:48:0)
[02:21:02.432] Timer tick, asking Buildbucket for the build status
[02:21:03.234] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:03.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:49:0) after 1m0s
[02:22:03.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:49:0)
[02:22:03.271] Timer tick, asking Buildbucket for the build status
[02:22:03.391] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:03.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:50:0) after 1m0s
[02:23:03.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:50:0)
[02:23:03.410] Timer tick, asking Buildbucket for the build status
[02:23:03.977] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:03.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:51:0) after 1m0s
[02:24:03.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:51:0)
[02:24:03.999] Timer tick, asking Buildbucket for the build status
[02:24:04.210] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:04.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:52:0) after 1m0s
[02:25:04.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:52:0)
[02:25:04.234] Timer tick, asking Buildbucket for the build status
[02:25:07.229] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:07.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:53:0) after 1m0s
[02:26:07.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:53:0)
[02:26:07.257] Timer tick, asking Buildbucket for the build status
[02:26:11.191] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:11.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:54:0) after 1m0s
[02:27:11.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:54:0)
[02:27:11.214] Timer tick, asking Buildbucket for the build status
[02:27:11.362] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:11.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:55:0) after 1m0s
[02:28:11.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:55:0)
[02:28:11.353] Timer tick, asking Buildbucket for the build status
[02:28:12.819] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:12.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:56:0) after 1m0s
[02:29:12.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:56:0)
[02:29:12.865] Timer tick, asking Buildbucket for the build status
[02:29:14.543] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:57:0) after 1m0s
[02:30:14.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:57:0)
[02:30:14.617] Timer tick, asking Buildbucket for the build status
[02:30:15.336] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:15.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:58:0) after 1m0s
[02:31:15.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:58:0)
[02:31:15.361] Timer tick, asking Buildbucket for the build status
[02:31:16.387] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:16.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:59:0) after 1m0s
[02:32:16.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:59:0)
[02:32:16.410] Timer tick, asking Buildbucket for the build status
[02:32:17.163] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:17.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:60:0) after 1m0s
[02:33:17.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:60:0)
[02:33:17.187] Timer tick, asking Buildbucket for the build status
[02:33:18.234] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:18.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:61:0) after 1m0s
[02:34:18.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:61:0)
[02:34:18.254] Timer tick, asking Buildbucket for the build status
[02:34:18.391] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:18.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:62:0) after 1m0s
[02:35:18.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:62:0)
[02:35:18.424] Timer tick, asking Buildbucket for the build status
[02:35:21.716] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:21.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:63:0) after 1m0s
[02:36:21.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:63:0)
[02:36:21.739] Timer tick, asking Buildbucket for the build status
[02:36:21.908] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:21.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:64:0) after 1m0s
[02:37:21.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:64:0)
[02:37:21.933] Timer tick, asking Buildbucket for the build status
[02:37:22.168] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:22.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:65:0) after 1m0s
[02:38:22.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:65:0)
[02:38:22.167] Timer tick, asking Buildbucket for the build status
[02:38:22.875] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:22.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:66:0) after 1m0s
[02:39:22.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:66:0)
[02:39:22.900] Timer tick, asking Buildbucket for the build status
[02:39:23.691] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:23.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:67:0) after 1m0s
[02:40:23.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:67:0)
[02:40:23.712] Timer tick, asking Buildbucket for the build status
[02:40:24.021] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:24.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:68:0) after 1m0s
[02:41:24.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:68:0)
[02:41:24.025] Timer tick, asking Buildbucket for the build status
[02:41:24.373] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:69:0) after 1m0s
[02:42:24.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:69:0)
[02:42:24.394] Timer tick, asking Buildbucket for the build status
[02:42:25.171] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:25.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:70:0) after 1m0s
[02:43:25.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:70:0)
[02:43:25.167] Timer tick, asking Buildbucket for the build status
[02:43:25.977] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:25.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:71:0) after 1m0s
[02:44:25.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:71:0)
[02:44:25.998] Timer tick, asking Buildbucket for the build status
[02:44:26.885] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:26.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:72:0) after 1m0s
[02:45:26.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:72:0)
[02:45:26.871] Timer tick, asking Buildbucket for the build status
[02:45:27.221] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:27.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:73:0) after 1m0s
[02:46:27.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:73:0)
[02:46:27.243] Timer tick, asking Buildbucket for the build status
[02:46:27.776] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:27.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:74:0) after 1m0s
[02:47:27.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:74:0)
[02:47:27.827] Timer tick, asking Buildbucket for the build status
[02:47:30.127] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:30.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:75:0) after 1m0s
[02:48:30.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:75:0)
[02:48:30.136] Timer tick, asking Buildbucket for the build status
[02:48:30.302] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:30.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:76:0) after 1m0s
[02:49:30.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:76:0)
[02:49:30.286] Timer tick, asking Buildbucket for the build status
[02:49:32.446] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:32.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:77:0) after 1m0s
[02:50:32.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:77:0)
[02:50:32.489] Timer tick, asking Buildbucket for the build status
[02:50:32.779] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:32.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:78:0) after 1m0s
[02:51:32.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:78:0)
[02:51:32.796] Timer tick, asking Buildbucket for the build status
[02:51:33.486] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:33.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:79:0) after 1m0s
[02:52:33.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:79:0)
[02:52:33.491] Timer tick, asking Buildbucket for the build status
[02:52:35.426] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:35.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:80:0) after 1m0s
[02:53:35.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:80:0)
[02:53:35.428] Timer tick, asking Buildbucket for the build status
[02:53:35.623] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:35.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:81:0) after 1m0s
[02:54:35.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:81:0)
[02:54:35.643] Timer tick, asking Buildbucket for the build status
[02:54:35.802] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:35.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:82:0) after 1m0s
[02:55:35.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:82:0)
[02:55:35.883] Timer tick, asking Buildbucket for the build status
[02:55:36.520] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:36.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:83:0) after 1m0s
[02:56:36.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:83:0)
[02:56:36.544] Timer tick, asking Buildbucket for the build status
[02:56:37.971] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:37.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:84:0) after 1m0s
[02:57:37.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:84:0)
[02:57:37.997] Timer tick, asking Buildbucket for the build status
[02:57:38.738] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:38.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:85:0) after 1m0s
[02:58:38.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:85:0)
[02:58:38.740] Timer tick, asking Buildbucket for the build status
[02:58:38.951] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:38.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:86:0) after 1m0s
[02:59:38.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:86:0)
[02:59:38.978] Timer tick, asking Buildbucket for the build status
[02:59:39.265] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:39.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:87:0) after 1m0s
[03:00:39.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:87:0)
[03:00:39.290] Timer tick, asking Buildbucket for the build status
[03:00:39.788] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:39.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:88:0) after 1m0s
[03:01:39.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:88:0)
[03:01:39.832] Timer tick, asking Buildbucket for the build status
[03:01:40.512] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:89:0) after 1m0s
[03:02:40.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:89:0)
[03:02:40.522] Timer tick, asking Buildbucket for the build status
[03:02:40.875] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:40.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:90:0) after 1m0s
[03:03:40.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:90:0)
[03:03:40.903] Timer tick, asking Buildbucket for the build status
[03:03:41.006] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:41.006] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:91:0) after 1m0s
[03:04:41.033] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:91:0)
[03:04:41.033] Timer tick, asking Buildbucket for the build status
[03:04:41.324] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:41.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:92:0) after 1m0s
[03:05:41.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:92:0)
[03:05:41.347] Timer tick, asking Buildbucket for the build status
[03:05:41.966] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:41.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:93:0) after 1m0s
[03:06:41.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:93:0)
[03:06:41.992] Timer tick, asking Buildbucket for the build status
[03:06:42.078] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:42.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:94:0) after 1m0s
[03:07:42.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:94:0)
[03:07:42.100] Timer tick, asking Buildbucket for the build status
[03:07:42.337] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:42.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:95:0) after 1m0s
[03:08:42.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:95:0)
[03:08:42.349] Timer tick, asking Buildbucket for the build status
[03:08:42.674] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:42.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:96:0) after 1m0s
[03:09:42.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:96:0)
[03:09:42.708] Timer tick, asking Buildbucket for the build status
[03:09:42.883] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:42.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:97:0) after 1m0s
[03:10:42.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:97:0)
[03:10:42.906] Timer tick, asking Buildbucket for the build status
[03:10:43.054] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:43.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:98:0) after 1m0s
[03:11:43.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:98:0)
[03:11:43.036] Timer tick, asking Buildbucket for the build status
[03:11:43.304] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:43.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:99:0) after 1m0s
[03:12:43.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:99:0)
[03:12:43.322] Timer tick, asking Buildbucket for the build status
[03:12:43.740] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:43.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:100:0) after 1m0s
[03:13:43.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:100:0)
[03:13:43.725] Timer tick, asking Buildbucket for the build status
[03:13:43.995] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:43.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:101:0) after 1m0s
[03:14:44.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:101:0)
[03:14:44.023] Timer tick, asking Buildbucket for the build status
[03:14:44.514] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:44.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:102:0) after 1m0s
[03:15:44.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:102:0)
[03:15:44.535] Timer tick, asking Buildbucket for the build status
[03:15:45.033] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:45.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:103:0) after 1m0s
[03:16:45.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:103:0)
[03:16:45.098] Timer tick, asking Buildbucket for the build status
[03:16:45.261] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:45.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:104:0) after 1m0s
[03:17:45.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:104:0)
[03:17:45.303] Timer tick, asking Buildbucket for the build status
[03:17:45.718] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:45.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:105:0) after 1m0s
[03:18:45.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:105:0)
[03:18:45.739] Timer tick, asking Buildbucket for the build status
[03:18:45.844] Build 8914611621949011392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:45.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080041683986885120:106:0) after 1m0s
[03:18:50.960] Received PubSub notification, asking Buildbucket for the build status
[03:18:51.146] Build 8914611621949011392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:18:51.146] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1556767130016617",
"created_by": "project:chromium",
"created_ts": "1556760877618853",
"id": "8914611621949011392",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0c2efc3c0040591113be07196f8389ae295171b8\"}}",
"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-4auu\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 13168, \"got_angle_revision\": \"3089f92e8a772ec675ea8f70ec1abca91b6b79ae\", \"got_dawn_revision\": \"00f6b1af41cab2dfa75a0c2759a3602307f2e9fd\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"0c2efc3c0040591113be07196f8389ae295171b8\", \"got_revision_cp\": \"refs/heads/master@{#655866}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"ea50a032a6e5e9c796e408bf2dafc14b767d9896\", \"got_v8_revision_cp\": \"refs/heads/7.6.81@{#1}\", \"got_webrtc_revision\": \"a0421d3d0cd7fac9e178900cbd59f5a2006615a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27818}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0c2efc3c0040591113be07196f8389ae295171b8\"}, \"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-4auu\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"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\": [\"4282-c170fa6\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1556760880593930",
"status": "COMPLETED",
"status_changed_ts": "1556767130668476",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/13168",
"builder:Windows deterministic",
"buildset:commit/git/0c2efc3c0040591113be07196f8389ae295171b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c2efc3c0040591113be07196f8389ae295171b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080041683986885120",
"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/8914611621949011392/+/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:448eff6a859fbb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1556767130671050",
"url": "https://ci.chromium.org/b/8914611621949011392",
"utcnow_ts": "1556767131135452"
}
}
[03:18:51.146] Invocation finished in 1h44m14.855545363s with status SUCCEEDED