[09:15:00.236] New invocation is queued and will start shortly
[09:15:01.468] Starting the invocation (attempt 1)
[09:15:01.501] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:15:01.501] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:15:01.501] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9101212408335796912",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d07754fc03da97240e0408a9258db85057650203\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9101212408335796912",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/d07754fc03da97240e0408a9258db85057650203",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07754fc03da97240e0408a9258db85057650203",
"gitiles_ref:refs/heads/master"
]
}
[09:15:04.575] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536570901692007",
"id": "8935782346145950640",
"lease_expiration_ts": "1536714904348604",
"lease_key": "1344376756",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d07754fc03da97240e0408a9258db85057650203\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1536570904481209",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10038",
"builder:Windows deterministic",
"buildset:commit/git/d07754fc03da97240e0408a9258db85057650203",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07754fc03da97240e0408a9258db85057650203",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101212408335796912",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10038",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935782346145950640",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/d07754fc03da97240e0408a9258db85057650203",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07754fc03da97240e0408a9258db85057650203",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8935782346145950640/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101212408335796912",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:71d843ea58cc76a6b4422ca80f2115179bb30d7f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fdb94d62ea97a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1536570904481296",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10038",
"utcnow_ts": "1536570904565098"
}
}
[09:15:04.575] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10038
[09:15:04.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:2:0) after 1m0s
[09:15:07.669] Received PubSub notification, asking Buildbucket for the build status
[09:15:07.705] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:04.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:2:0)
[09:16:04.600] Timer tick, asking Buildbucket for the build status
[09:16:04.735] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:4:0) after 1m0s
[09:17:04.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:4:0)
[09:17:04.754] Timer tick, asking Buildbucket for the build status
[09:17:04.884] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:04.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:5:0) after 1m0s
[09:18:04.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:5:0)
[09:18:04.902] Timer tick, asking Buildbucket for the build status
[09:18:04.985] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:04.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:6:0) after 1m0s
[09:19:05.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:6:0)
[09:19:05.001] Timer tick, asking Buildbucket for the build status
[09:19:08.563] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:08.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:7:0) after 1m0s
[09:20:08.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:7:0)
[09:20:08.581] Timer tick, asking Buildbucket for the build status
[09:20:08.626] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:08.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:8:0) after 1m0s
[09:21:08.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:8:0)
[09:21:08.646] Timer tick, asking Buildbucket for the build status
[09:21:08.827] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:08.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:9:0) after 1m0s
[09:22:08.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:9:0)
[09:22:08.845] Timer tick, asking Buildbucket for the build status
[09:22:08.897] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:08.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:10:0) after 1m0s
[09:23:08.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:10:0)
[09:23:08.913] Timer tick, asking Buildbucket for the build status
[09:23:08.956] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:08.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:11:0) after 1m0s
[09:24:08.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:11:0)
[09:24:08.975] Timer tick, asking Buildbucket for the build status
[09:24:09.035] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:09.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:12:0) after 1m0s
[09:25:09.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:12:0)
[09:25:09.054] Timer tick, asking Buildbucket for the build status
[09:25:09.124] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:09.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:13:0) after 1m0s
[09:26:09.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:13:0)
[09:26:09.142] Timer tick, asking Buildbucket for the build status
[09:26:09.177] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:09.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:14:0) after 1m0s
[09:27:09.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:14:0)
[09:27:09.194] Timer tick, asking Buildbucket for the build status
[09:27:09.235] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:09.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:15:0) after 1m0s
[09:28:09.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:15:0)
[09:28:09.254] Timer tick, asking Buildbucket for the build status
[09:28:09.296] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:09.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:16:0) after 1m0s
[09:29:09.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:16:0)
[09:29:09.314] Timer tick, asking Buildbucket for the build status
[09:29:09.376] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:09.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:17:0) after 1m0s
[09:30:09.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:17:0)
[09:30:09.405] Timer tick, asking Buildbucket for the build status
[09:30:09.479] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:09.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:18:0) after 1m0s
[09:31:09.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:18:0)
[09:31:09.497] Timer tick, asking Buildbucket for the build status
[09:31:09.567] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:09.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:19:0) after 1m0s
[09:32:09.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:19:0)
[09:32:09.583] Timer tick, asking Buildbucket for the build status
[09:32:09.655] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:09.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:20:0) after 1m0s
[09:33:09.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:20:0)
[09:33:09.676] Timer tick, asking Buildbucket for the build status
[09:33:09.728] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:09.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:21:0) after 1m0s
[09:34:09.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:21:0)
[09:34:09.761] Timer tick, asking Buildbucket for the build status
[09:34:09.851] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:09.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:22:0) after 1m0s
[09:35:09.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:22:0)
[09:35:09.876] Timer tick, asking Buildbucket for the build status
[09:35:09.935] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:09.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:23:0) after 1m0s
[09:36:09.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:23:0)
[09:36:09.954] Timer tick, asking Buildbucket for the build status
[09:36:10.010] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:10.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:24:0) after 1m0s
[09:37:10.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:24:0)
[09:37:10.057] Timer tick, asking Buildbucket for the build status
[09:37:10.089] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:10.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:25:0) after 1m0s
[09:38:10.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:25:0)
[09:38:10.109] Timer tick, asking Buildbucket for the build status
[09:38:10.210] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:10.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:26:0) after 1m0s
[09:39:10.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:26:0)
[09:39:10.242] Timer tick, asking Buildbucket for the build status
[09:39:10.341] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:10.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:27:0) after 1m0s
[09:40:10.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:27:0)
[09:40:10.371] Timer tick, asking Buildbucket for the build status
[09:40:10.499] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:10.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:28:0) after 1m0s
[09:41:10.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:28:0)
[09:41:10.522] Timer tick, asking Buildbucket for the build status
[09:41:10.580] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:10.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:29:0) after 1m0s
[09:42:10.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:29:0)
[09:42:10.601] Timer tick, asking Buildbucket for the build status
[09:42:10.656] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:10.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:30:0) after 1m0s
[09:43:10.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:30:0)
[09:43:10.737] Timer tick, asking Buildbucket for the build status
[09:43:10.793] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:31:0) after 1m0s
[09:44:10.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:31:0)
[09:44:10.815] Timer tick, asking Buildbucket for the build status
[09:44:10.882] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:10.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:32:0) after 1m0s
[09:45:10.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:32:0)
[09:45:10.900] Timer tick, asking Buildbucket for the build status
[09:45:10.961] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:10.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:33:0) after 1m0s
[09:46:10.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:33:0)
[09:46:10.979] Timer tick, asking Buildbucket for the build status
[09:46:11.042] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:11.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:34:0) after 1m0s
[09:47:11.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:34:0)
[09:47:11.065] Timer tick, asking Buildbucket for the build status
[09:47:11.099] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:11.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:35:0) after 1m0s
[09:48:11.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:35:0)
[09:48:11.118] Timer tick, asking Buildbucket for the build status
[09:48:11.184] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:11.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:36:0) after 1m0s
[09:49:11.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:36:0)
[09:49:11.219] Timer tick, asking Buildbucket for the build status
[09:49:11.290] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:11.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:37:0) after 1m0s
[09:50:11.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:37:0)
[09:50:11.309] Timer tick, asking Buildbucket for the build status
[09:50:11.366] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:11.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:38:0) after 1m0s
[09:51:11.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:38:0)
[09:51:11.385] Timer tick, asking Buildbucket for the build status
[09:51:11.415] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:11.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:39:0) after 1m0s
[09:52:11.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:39:0)
[09:52:11.436] Timer tick, asking Buildbucket for the build status
[09:52:11.498] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:11.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:40:0) after 1m0s
[09:53:11.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:40:0)
[09:53:11.518] Timer tick, asking Buildbucket for the build status
[09:53:11.555] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:11.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:41:0) after 1m0s
[09:54:11.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:41:0)
[09:54:11.613] Timer tick, asking Buildbucket for the build status
[09:54:11.662] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:11.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:42:0) after 1m0s
[09:55:11.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:42:0)
[09:55:11.824] Timer tick, asking Buildbucket for the build status
[09:55:11.894] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:11.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:43:0) after 1m0s
[09:56:11.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:43:0)
[09:56:11.919] Timer tick, asking Buildbucket for the build status
[09:56:11.993] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:11.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:44:0) after 1m0s
[09:57:12.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:44:0)
[09:57:12.013] Timer tick, asking Buildbucket for the build status
[09:57:12.073] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:12.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:45:0) after 1m0s
[09:58:12.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:45:0)
[09:58:12.125] Timer tick, asking Buildbucket for the build status
[09:58:12.192] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:12.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:46:0) after 1m0s
[09:59:12.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:46:0)
[09:59:12.350] Timer tick, asking Buildbucket for the build status
[09:59:12.538] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:12.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:47:0) after 1m0s
[10:00:12.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:47:0)
[10:00:12.559] Timer tick, asking Buildbucket for the build status
[10:00:13.325] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:13.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:48:0) after 1m0s
[10:01:13.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:48:0)
[10:01:13.345] Timer tick, asking Buildbucket for the build status
[10:01:13.393] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:13.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:49:0) after 1m0s
[10:02:13.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:49:0)
[10:02:13.415] Timer tick, asking Buildbucket for the build status
[10:02:13.707] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:13.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:50:0) after 1m0s
[10:03:13.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:50:0)
[10:03:13.746] Timer tick, asking Buildbucket for the build status
[10:03:13.818] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:13.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:51:0) after 1m0s
[10:04:13.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:51:0)
[10:04:13.840] Timer tick, asking Buildbucket for the build status
[10:04:14.293] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:14.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:52:0) after 1m0s
[10:05:14.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:52:0)
[10:05:14.314] Timer tick, asking Buildbucket for the build status
[10:05:14.392] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:14.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:53:0) after 1m0s
[10:06:14.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:53:0)
[10:06:14.411] Timer tick, asking Buildbucket for the build status
[10:06:14.473] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:14.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:54:0) after 1m0s
[10:07:14.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:54:0)
[10:07:14.496] Timer tick, asking Buildbucket for the build status
[10:07:14.780] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:14.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:55:0) after 1m0s
[10:08:14.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:55:0)
[10:08:14.804] Timer tick, asking Buildbucket for the build status
[10:08:14.973] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:14.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:56:0) after 1m0s
[10:09:14.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:56:0)
[10:09:14.994] Timer tick, asking Buildbucket for the build status
[10:09:15.056] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:15.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:57:0) after 1m0s
[10:10:15.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:57:0)
[10:10:15.078] Timer tick, asking Buildbucket for the build status
[10:10:15.145] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:15.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:58:0) after 1m0s
[10:11:15.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:58:0)
[10:11:15.170] Timer tick, asking Buildbucket for the build status
[10:11:15.227] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:15.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:59:0) after 1m0s
[10:12:15.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:59:0)
[10:12:15.768] Timer tick, asking Buildbucket for the build status
[10:12:15.828] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:15.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:60:0) after 1m0s
[10:13:17.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:60:0)
[10:13:17.693] Timer tick, asking Buildbucket for the build status
[10:13:17.867] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:17.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:61:0) after 1m0s
[10:14:18.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:61:0)
[10:14:18.025] Timer tick, asking Buildbucket for the build status
[10:14:18.155] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:18.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:62:0) after 1m0s
[10:15:18.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:62:0)
[10:15:18.176] Timer tick, asking Buildbucket for the build status
[10:15:18.240] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:18.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:63:0) after 1m0s
[10:16:18.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:63:0)
[10:16:18.277] Timer tick, asking Buildbucket for the build status
[10:16:18.313] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:18.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:64:0) after 1m0s
[10:17:18.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:64:0)
[10:17:18.417] Timer tick, asking Buildbucket for the build status
[10:17:18.559] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:18.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:65:0) after 1m0s
[10:18:19.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:65:0)
[10:18:19.061] Timer tick, asking Buildbucket for the build status
[10:18:19.350] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:19.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:66:0) after 1m0s
[10:19:19.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:66:0)
[10:19:19.370] Timer tick, asking Buildbucket for the build status
[10:19:19.459] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:19.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:67:0) after 1m0s
[10:20:20.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:67:0)
[10:20:20.169] Timer tick, asking Buildbucket for the build status
[10:20:20.244] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:20.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:68:0) after 1m0s
[10:21:21.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:68:0)
[10:21:21.254] Timer tick, asking Buildbucket for the build status
[10:21:21.448] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:21.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:69:0) after 1m0s
[10:22:22.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:69:0)
[10:22:22.638] Timer tick, asking Buildbucket for the build status
[10:22:22.850] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:22.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:70:0) after 1m0s
[10:23:23.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:70:0)
[10:23:23.920] Timer tick, asking Buildbucket for the build status
[10:23:23.963] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:23.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:71:0) after 1m0s
[10:24:25.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:71:0)
[10:24:25.046] Timer tick, asking Buildbucket for the build status
[10:24:25.229] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:25.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:72:0) after 1m0s
[10:25:25.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:72:0)
[10:25:25.310] Timer tick, asking Buildbucket for the build status
[10:25:25.386] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:25.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:73:0) after 1m0s
[10:26:26.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:73:0)
[10:26:26.112] Timer tick, asking Buildbucket for the build status
[10:26:26.206] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:26.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:74:0) after 1m0s
[10:27:27.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:74:0)
[10:27:27.471] Timer tick, asking Buildbucket for the build status
[10:27:27.632] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:27.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:75:0) after 1m0s
[10:28:28.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:75:0)
[10:28:28.704] Timer tick, asking Buildbucket for the build status
[10:28:28.737] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:28.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:76:0) after 1m0s
[10:29:29.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:76:0)
[10:29:29.776] Timer tick, asking Buildbucket for the build status
[10:29:29.813] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:29.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:77:0) after 1m0s
[10:30:29.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:77:0)
[10:30:29.850] Timer tick, asking Buildbucket for the build status
[10:30:30.023] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:30.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:78:0) after 1m0s
[10:31:30.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:78:0)
[10:31:30.915] Timer tick, asking Buildbucket for the build status
[10:31:30.978] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:30.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:79:0) after 1m0s
[10:32:32.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:79:0)
[10:32:32.240] Timer tick, asking Buildbucket for the build status
[10:32:32.309] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:32.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:80:0) after 1m0s
[10:33:32.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:80:0)
[10:33:32.479] Timer tick, asking Buildbucket for the build status
[10:33:32.516] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:32.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:81:0) after 1m0s
[10:34:33.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:81:0)
[10:34:33.600] Timer tick, asking Buildbucket for the build status
[10:34:33.663] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:82:0) after 1m0s
[10:35:34.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:82:0)
[10:35:34.330] Timer tick, asking Buildbucket for the build status
[10:35:34.547] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:34.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:83:0) after 1m0s
[10:36:35.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:83:0)
[10:36:35.497] Timer tick, asking Buildbucket for the build status
[10:36:35.555] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:35.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:84:0) after 1m0s
[10:37:36.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:84:0)
[10:37:36.671] Timer tick, asking Buildbucket for the build status
[10:37:36.805] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:85:0) after 1m0s
[10:38:37.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:85:0)
[10:38:37.837] Timer tick, asking Buildbucket for the build status
[10:38:37.894] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:37.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:86:0) after 1m0s
[10:39:38.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:86:0)
[10:39:38.540] Timer tick, asking Buildbucket for the build status
[10:39:38.664] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:38.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:87:0) after 1m0s
[10:40:39.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:87:0)
[10:40:39.723] Timer tick, asking Buildbucket for the build status
[10:40:39.759] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:39.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:88:0) after 1m0s
[10:41:40.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:88:0)
[10:41:40.937] Timer tick, asking Buildbucket for the build status
[10:41:41.021] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:41.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:89:0) after 1m0s
[10:42:42.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:89:0)
[10:42:42.154] Timer tick, asking Buildbucket for the build status
[10:42:42.219] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:42.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:90:0) after 1m0s
[10:43:43.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:90:0)
[10:43:43.458] Timer tick, asking Buildbucket for the build status
[10:43:43.614] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:43.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:91:0) after 1m0s
[10:44:43.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:91:0)
[10:44:43.655] Timer tick, asking Buildbucket for the build status
[10:44:43.883] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:43.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:92:0) after 1m0s
[10:45:43.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:92:0)
[10:45:43.907] Timer tick, asking Buildbucket for the build status
[10:45:44.016] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:44.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:93:0) after 1m0s
[10:46:45.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:93:0)
[10:46:45.184] Timer tick, asking Buildbucket for the build status
[10:46:45.256] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:45.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:94:0) after 1m0s
[10:47:46.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:94:0)
[10:47:46.343] Timer tick, asking Buildbucket for the build status
[10:47:46.403] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:46.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:95:0) after 1m0s
[10:48:47.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:95:0)
[10:48:47.495] Timer tick, asking Buildbucket for the build status
[10:48:47.554] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:47.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:96:0) after 1m0s
[10:49:47.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:96:0)
[10:49:47.582] Timer tick, asking Buildbucket for the build status
[10:49:47.645] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:47.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:97:0) after 1m0s
[10:50:47.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:97:0)
[10:50:47.670] Timer tick, asking Buildbucket for the build status
[10:50:47.749] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:47.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:98:0) after 1m0s
[10:51:48.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:98:0)
[10:51:48.837] Timer tick, asking Buildbucket for the build status
[10:51:48.891] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:48.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:99:0) after 1m0s
[10:52:50.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:99:0)
[10:52:50.130] Timer tick, asking Buildbucket for the build status
[10:52:50.196] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:50.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:100:0) after 1m0s
[10:53:51.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:100:0)
[10:53:51.256] Timer tick, asking Buildbucket for the build status
[10:53:51.391] Build 8935782346145950640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:51.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101212408335796912:101:0) after 1m0s
[10:54:37.747] Received PubSub notification, asking Buildbucket for the build status
[10:54:37.819] Build 8935782346145950640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:54:37.819] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1536576876108112",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536570901692007",
"id": "8935782346145950640",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d07754fc03da97240e0408a9258db85057650203\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8935782346145950640/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3769-3c22b45\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"cb6ec4b1f91af259cbdfd1bd22bb98ed5551955e\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"d07754fc03da97240e0408a9258db85057650203\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24631}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#589866}\", \"branch\": \"refs/heads/master\", \"revision\": \"d07754fc03da97240e0408a9258db85057650203\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d7027dc081cb96791b51524210aa249eb301c056\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"a735ee2f6df8ec7ef55207e7fdffcbac87b900af\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1536570901692007, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/d07754fc03da97240e0408a9258db85057650203\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07754fc03da97240e0408a9258db85057650203\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9101212408335796912\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8935782346145950640\"}}, \"got_v8_revision\": \"abc91d4174d4019369c60b31b45a440e8ece6682\", \"got_v8_revision_cp\": \"refs/heads/7.1.70@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10038, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"a37146f56f2aa84f880c56cbcb4ebbb940a68fe3\", \"notification_helper_unittests\": \"32cfc7f8f1555446468fbbf0199d8cc74e197d39\", \"gpu_perftests\": \"ce52b98fbd5493360bdb6e2ee3167edd0a702631\", \"vr_common_unittests\": \"0ec0ab3b79f792e3370d68e94a3ddaba8c4f2f46\", \"telemetry_unittests\": \"7b2607c2592c661822264d09a89b822b75199df6\", \"load_library_perf_tests\": \"f8433b5977ac918e2ed1b42981639446302dfff6\", \"devtools_closure_compile\": \"5d580efa65fb051a58fd7467b45b5a954f8ed6b2\", \"chromedriver_py_tests\": \"4e025125df539b695d85ca53b0dab5fe3b843028\", \"mojo_core_unittests\": \"96bb3564df74911aa49fcd095a19d0bc65d28ac8\", \"install_static_unittests\": \"f30fa77e909750b502fb327804c6f7ab168acdfa\", \"leveldb_service_unittests\": \"feee4adf625ac48555632abfce077fb4e042025b\", \"mini_installer_tests\": \"195e68b4302b3f0ba511414b240661e093af804c\", \"jingle_unittests\": \"24c0b401e32dd14401ac0ad404a30da8a01e086e\", \"sbox_integration_tests\": \"6a8efcace5926889b88ab179d0ff84f14b1372f3\", \"angle_unittests\": \"157d877423624e3bcc3b29cb1907766251acf286\", \"cast_unittests\": \"9376b3e4eda9f0793407dfc60c3aba8e51fe2e60\", \"cc_unittests\": \"448906423a0e9fd703826e66e1aefa32ee4d1dbf\", \"blink_common_unittests\": \"f426df9b29d55f82c5b4d32a7cd67f2e6e07a2aa\", \"crashpad_tests\": \"10a7366506ce9426a901288fae0c38c0744a1fc9\", \"telemetry_perf_tests_without_chrome\": \"f922870b7bb494b4c4455733a6cd8c16cb39e1b3\", \"metrics_python_tests\": \"a54ccbdcb57a0d4e104d4d9469fa880fb724183b\", \"message_center_unittests\": \"983b7cc79b94f3fad2d9b3c6fb89024942780b3b\", \"ppapi_unittests\": \"b78e061c2927bfd6af6fb094c0d1b8dd803433da\", \"extensions_unittests\": \"d517890a460a3c8b7a3fd264ad8d7a73d8f7c639\", \"gl_unittests_ozone\": \"64ee98d9aa50eed393b0aeac24bebbb2d2b9d92a\", \"app_shell_unittests\": \"8d2333b9f7f79b67d3a76ac21b5559e85d7e56c1\", \"chrome_app_unittests\": \"5117a973099b4eb8c7c690133b4c30747ead4c22\", \"gl_unittests\": \"64ee98d9aa50eed393b0aeac24bebbb2d2b9d92a\", \"gcm_unit_tests\": \"75f26ec4636a1b4424a72eea834adff8877dd7ee\", \"views_unittests\": \"caea6372c5b741b75cfe540f0fa032869c2576c4\", \"content_shell_crash_test\": \"28274a4ea9eea55c5e203752574768a6332e8c03\", \"ui_base_unittests\": \"7f60f3caf18d0b4ef117987d258afe489a36bec2\", \"gles2_conform_test\": \"ddbc258d08fca836cec02de445efa105abeeba1d\", \"cronet_unittests\": \"2d533a1939c35882d258be3ebd69942053e8ce5b\", \"performance_test_suite\": \"feeb3fa7ca8a7bc61ae2c24bc2574ed67dcce8c8\", \"wm_unittests\": \"40af2c53b68930e83a80e5aa06e57db5d4f3798c\", \"boringssl_crypto_tests\": \"87b6c3e0c6ea49be86b5b64d51b5807a6bf98bd7\", \"gin_unittests\": \"cf1c4f5d99497cac0298feddee7c178b4cd78103\", \"performance_browser_tests\": \"0dda95d894e14060a9d9ebbdbec0e035ee3796d0\", \"extensions_browsertests\": \"161746ddb2757e07c7b47177531344d4d0bc359e\", \"webkit_python_tests\": \"cb5b1130f6e2651f6053cb41091e45d3be71b95a\", \"headless_unittests\": \"ed626f224058bb2d38d24ce96b76cbd5cce64f30\", \"webkit_layout_tests\": \"c5e60c714054d710e30a0ec99ba574611574be67\", \"vr_pixeltests\": \"902ecd9a8253d9614c3af92f13111f026576110b\", \"setup_unittests\": \"5474b6ca50a77899d9f63802cd67f32d669ca588\", \"webkit_unit_tests\": \"a4c54b6d31e76ea72f2ab91a64d7df0f4e2aabdd\", \"content_unittests\": \"422cef3843e4036ff54dbeae139f00ef440dfe1d\", \"performance_webview_test_suite\": \"0c3d87dc8f8c75e86c69706ce72e961fbbcf5b3d\", \"wtf_unittests\": \"b53996161985bbc0c016533a53e1323c5f1ca2ad\", \"webkit_layout_tests_exparchive\": \"bfd6ca50927da10d25321a63e4e160ff0a7b3604\", \"chrome_cleaner_unittests\": \"a4d5f043ab71e94ed27d9cb03388c71293e13670\", \"traffic_annotation_auditor_unittests\": \"2708d2567302359a3d82700e3144f50b02f5cb5b\", \"libjingle_xmpp_unittests\": \"b05108b2abcfdc49c2b9f934a08dce5a2b439bbd\", \"remoting_unittests\": \"942237a357b1693b80e683e39a9ace0c1134c2e0\", \"vr_common_perftests\": \"3599e59a48e91011a44a15b683653665d61e8fcc\", \"filesystem_service_unittests\": \"666820f3f897b20e6943cd266b76d613a6ad391f\", \"chrome_elf_import_unittests\": \"e369bfadb13903016b54a26b55fd87a11404ab9b\", \"installer_util_unittests\": \"c528efe31f75c3da9edb357bbefd636a8a45ac2e\", \"gfx_unittests\": \"f6b611f0518111f4dff91f3568368275250aa2c5\", \"headless_browsertests\": \"2e7080fd3e93ac21f34c1fdae109ccbcf874a3d0\", \"capture_unittests\": \"92abcf317f2793f09047fec996487654cd257e5c\", \"chrome_elf_unittests\": \"1ca8704d99774ed9d285377d290ac3b4509fb800\", \"telemetry_gpu_unittests\": \"0712f83d74fadc282e2dc909afa1f8c3993b6dd6\", \"command_buffer_perftests\": \"868f5b69792482d4fc2c74281051ae31df89a511\", \"media_unittests\": \"5d61e46b37469c6813ceebdb6b31e84dcfd8d64e\", \"chromedriver_unittests\": \"af152df5478252501e744b18d35aba6389e3467d\", \"views_mus_interactive_ui_tests\": \"4a02acb3291e8efff2710e674536bc8b78f69980\", \"storage_unittests\": \"6266ceb381de8c0d50ea95bdd5d6a3626be79c70\", \"media_service_unittests\": \"cda05f15407ec7fd203738e372be9e2c2647929a\", \"compositor_unittests\": \"024180609bcb165c283dead8de51c283583ab952\", \"latency_unittests\": \"0cbff624c355ec3e14849b9a1a393cdc38726a4e\", \"video_decode_accelerator_unittest\": \"6df8535cb0221ff6c44f20efe676c5320d7d8e1f\", \"swiftshader_unittests\": \"80ea8ffe921225aedafa0c4a5c964e89af3e669e\", \"telemetry_perf_unittests\": \"30c1ecad872f3e492f3daa73f11ed1cb5a7334a8\", \"media_blink_unittests\": \"2ef2f859e8f080037215e99f07ab34dfd72a9053\", \"views_mus_unittests\": \"9145e0b1f414b71b2eb1bc33993c4a9e60966570\", \"components_unittests\": \"d5344b71148c2ae5d55677ba33d98ece4688fdea\", \"snapshot_unittests\": \"f28760c696e0632319d7f566cdc513582ab7041a\", \"accessibility_unittests\": \"3a81b88dee50c1feaebd3b6da0c5ea44941eb38f\", \"net_perftests\": \"fc958f1f83b60e968b86cd6ca7e2e8725d4adddc\", \"aura_unittests\": \"0a8ed157982703dd10f52e9d8035e16189c427b7\", \"services_unittests\": \"ce51032f0c42f6e68d31531caae393f759b80d8e\", \"components_perftests\": \"8d07de88e7ce56efaeccc2ba964ea008ba3d791a\", \"events_unittests\": \"5674f6404722ae907f44c55f7e43ed1a00742b78\", \"tracing_perftests\": \"5dca39de8d940c7d6d65c15bb0cfb7e3cbfe3713\", \"chromedriver_replay_unittests\": \"e2ec5b5deadfbf1a0e00246e86e8f3e11e9cace0\", \"ui_touch_selection_unittests\": \"fbb784ad36fd97d0a47cea90102be956501b49bb\", \"cacheinvalidation_unittests\": \"35f544cd39355e85d0f656b8111656bf14dbdcff\", \"viz_unittests\": \"38db58ae214c0103d0ce45894bc55fc1eb542411\", \"browser_tests\": \"6e923b6d6781cfb94e7fd28ce45c28a54672bdc9\", \"net_unittests\": \"454e6a34106ddb23342a92eac9b06368db8d7b78\", \"midi_unittests\": \"978b76d0c252acfb2cf35a35c1a39eefd0632bc2\", \"boringssl_ssl_tests\": \"a087de3585d217e18bcc29f88245d6429dfd72d3\", \"sbox_validation_tests\": \"d2d1ce3237739718581478963a0607780f909821\", \"elevation_service_unittests\": \"33ae0bdadec3c5cc522a98066be3aa562d84f6cf\", \"gpu_unittests\": \"c87798e0f6d16c8339b778869986daf531a720fb\", \"native_theme_unittests\": \"7bd1497d5d163dcb3df63929b245c5a7dce5adf5\", \"interactive_ui_tests\": \"bcc09864aef815788a242e4c97ae7bb1abd2ccda\", \"mojo_unittests\": \"61dacdd6bfecd5c71cb9c7b1057dcb389116fef1\", \"url_unittests\": \"ac1551a0049ae2e794e36b28017b8857474130d7\", \"media_perftests\": \"1367ba23a65d0597c2c5a336029db15864dd9444\", \"cronet_tests\": \"1a11ffc1af2e503578be20a799b846a440dd27c2\", \"google_apis_unittests\": \"91201e7314ad0ec0e0a2ac2cfc83ca6966b48157\", \"telemetry_gpu_integration_test\": \"ead235cd22d6d405d264ee74cf53239b0724e3b3\", \"blink_heap_unittests\": \"9c5ffda5022f20ab5f2b7db3464e584b14f7f9ec\", \"base_unittests\": \"2c29a0cadbf1d1f8d0f92af0e0a5668ce74687b5\", \"sync_integration_tests\": \"75157344f7fb2797735d0985f555c5a9099282b3\", \"sql_unittests\": \"d8f89f698e23195e74d0985aec34edc2397642cf\", \"courgette_unittests\": \"efba834b138eace53c2d53350843301a3f506f0e\", \"blink_fuzzer_unittests\": \"1adb95af040fe742b1c547d0344e3ff0bc17a33f\", \"gl_tests\": \"1e05e8eaca5ded742104623d2518e8d38a7b128d\", \"zucchini_unittests\": \"323f07c22a18797ec734e01390dfcff41239a12d\", \"ipc_tests\": \"f4b22c008e3f5c3443d111d4c96a301cd686b60e\", \"angle_end2end_tests\": \"de04e22a3587f2e9a518857e2f40e879b29d3a51\", \"blink_platform_unittests\": \"f6af660bef6c7586cde183c2eed163e8f8daf747\", \"components_browsertests\": \"e6c49dba1fdec062e78ab4b225c3d589051536b3\", \"views_perftests\": \"a075447316c8bbe4a79cd3acca26949fe539a937\", \"angle_perftests\": \"62c7e39e2e1ea758a6b0fe96aed6b7d57b0acc5a\", \"display_unittests\": \"a9a60c95a8c3624910daf4c30c2ca7b1e7ec06c7\", \"sbox_unittests\": \"b245459ad2dbd8810573c529993824ad7a2a3418\", \"service_manager_unittests\": \"0204402099799faeec0dd54fa5bc252e8bdcce26\", \"pdf_unittests\": \"1b54efc6e0e56c6176dd6d54b7e580c3f971f890\", \"skia_unittests\": \"399891f0d90d0b4298e8f6aa41c9bdc85b93e797\", \"angle_white_box_tests\": \"f93f612ceb283c0d718c797ccb27bd361aefd6a8\", \"crypto_unittests\": \"14f3652905d9a2f56d6d02d2e0cd78dbdc9718ca\", \"nacl_loader_unittests\": \"e71c2532a69ad3b67d7ee07b0d52a04996d6b158\", \"unit_tests\": \"4fa5b62dce05c27fefbf6a28917b2347c7a83f6f\", \"content_browsertests\": \"4a40545ca71aff7057073c60e7e8032a31ac6486\", \"printing_unittests\": \"5de76a45f92b888a59722b226036866c888c7138\", \"device_unittests\": \"0c1201a9fb8bfad71a996623f090bd482e4d472a\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1536570906812412",
"status": "COMPLETED",
"status_changed_ts": "1536576877253075",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10038",
"builder:Windows deterministic",
"buildset:commit/git/d07754fc03da97240e0408a9258db85057650203",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07754fc03da97240e0408a9258db85057650203",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101212408335796912",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10038",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935782346145950640",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/d07754fc03da97240e0408a9258db85057650203",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07754fc03da97240e0408a9258db85057650203",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8935782346145950640/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101212408335796912",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:71d843ea58cc76a6b4422ca80f2115179bb30d7f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fdb94d62ea97a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1536576877255140",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10038",
"utcnow_ts": "1536576877801913"
}
}
[10:54:37.819] Invocation finished in 1h39m37.599395471s with status SUCCEEDED