[23:26:16.390] New invocation is queued and will start shortly
[23:26:17.696] Starting the invocation (attempt 1)
[23:26:17.729] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:26:17.729] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:26:17.729] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9100705866325368112",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"26aad747934718e6a909ded290befdf0408e9355\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9100705866325368112",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/26aad747934718e6a909ded290befdf0408e9355",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26aad747934718e6a909ded290befdf0408e9355",
"gitiles_ref:refs/heads/master"
]
}
[23:26:21.378] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537053977885518",
"id": "8935275804043261792",
"lease_expiration_ts": "1537197981129726",
"lease_key": "348124918",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"26aad747934718e6a909ded290befdf0408e9355\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1537053981287291",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10100",
"builder:Windows deterministic",
"buildset:commit/git/26aad747934718e6a909ded290befdf0408e9355",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26aad747934718e6a909ded290befdf0408e9355",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9100705866325368112",
"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/10100",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935275804043261792",
"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/26aad747934718e6a909ded290befdf0408e9355",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26aad747934718e6a909ded290befdf0408e9355",
"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/8935275804043261792/+/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:9100705866325368112",
"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:1ac7d09cc4a2ea082595b18a4d4396092aef4e9e",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3ff85fffb8661710",
"user_agent:luci-scheduler"
],
"updated_ts": "1537053981287377",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10100",
"utcnow_ts": "1537053981367157"
}
}
[23:26:21.378] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10100
[23:26:21.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:2:0) after 1m0s
[23:26:25.892] Received PubSub notification, asking Buildbucket for the build status
[23:26:25.942] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:21.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:2:0)
[23:27:21.394] Timer tick, asking Buildbucket for the build status
[23:27:21.540] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:21.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:4:0) after 1m0s
[23:28:21.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:4:0)
[23:28:21.557] Timer tick, asking Buildbucket for the build status
[23:28:21.616] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:21.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:5:0) after 1m0s
[23:29:21.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:5:0)
[23:29:21.629] Timer tick, asking Buildbucket for the build status
[23:29:21.664] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:21.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:6:0) after 1m0s
[23:30:21.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:6:0)
[23:30:21.681] Timer tick, asking Buildbucket for the build status
[23:30:21.754] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:21.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:7:0) after 1m0s
[23:31:21.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:7:0)
[23:31:21.788] Timer tick, asking Buildbucket for the build status
[23:31:21.973] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:21.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:8:0) after 1m0s
[23:32:21.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:8:0)
[23:32:21.991] Timer tick, asking Buildbucket for the build status
[23:32:22.061] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:22.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:9:0) after 1m0s
[23:33:22.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:9:0)
[23:33:22.087] Timer tick, asking Buildbucket for the build status
[23:33:22.148] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:22.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:10:0) after 1m0s
[23:34:22.194] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:10:0)
[23:34:22.194] Timer tick, asking Buildbucket for the build status
[23:34:22.254] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:22.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:11:0) after 1m0s
[23:35:22.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:11:0)
[23:35:22.270] Timer tick, asking Buildbucket for the build status
[23:35:22.425] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:22.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:12:0) after 1m0s
[23:36:22.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:12:0)
[23:36:22.446] Timer tick, asking Buildbucket for the build status
[23:36:22.505] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:22.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:13:0) after 1m0s
[23:37:22.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:13:0)
[23:37:22.528] Timer tick, asking Buildbucket for the build status
[23:37:22.583] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:22.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:14:0) after 1m0s
[23:38:22.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:14:0)
[23:38:22.598] Timer tick, asking Buildbucket for the build status
[23:38:22.668] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:22.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:15:0) after 1m0s
[23:39:22.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:15:0)
[23:39:22.691] Timer tick, asking Buildbucket for the build status
[23:39:22.772] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:22.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:16:0) after 1m0s
[23:40:23.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:16:0)
[23:40:23.002] Timer tick, asking Buildbucket for the build status
[23:40:23.047] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:23.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:17:0) after 1m0s
[23:41:23.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:17:0)
[23:41:23.063] Timer tick, asking Buildbucket for the build status
[23:41:23.131] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:23.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:18:0) after 1m0s
[23:42:23.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:18:0)
[23:42:23.149] Timer tick, asking Buildbucket for the build status
[23:42:23.213] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:23.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:19:0) after 1m0s
[23:43:23.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:19:0)
[23:43:23.260] Timer tick, asking Buildbucket for the build status
[23:43:23.467] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:23.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:20:0) after 1m0s
[23:44:23.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:20:0)
[23:44:23.486] Timer tick, asking Buildbucket for the build status
[23:44:23.678] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:23.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:21:0) after 1m0s
[23:45:23.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:21:0)
[23:45:23.694] Timer tick, asking Buildbucket for the build status
[23:45:23.738] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:23.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:22:0) after 1m0s
[23:46:23.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:22:0)
[23:46:23.782] Timer tick, asking Buildbucket for the build status
[23:46:23.856] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:23.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:23:0) after 1m0s
[23:47:23.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:23:0)
[23:47:23.873] Timer tick, asking Buildbucket for the build status
[23:47:23.970] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:23.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:24:0) after 1m0s
[23:48:23.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:24:0)
[23:48:23.998] Timer tick, asking Buildbucket for the build status
[23:48:24.112] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:24.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:25:0) after 1m0s
[23:49:24.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:25:0)
[23:49:24.175] Timer tick, asking Buildbucket for the build status
[23:49:24.256] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:24.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:26:0) after 1m0s
[23:50:24.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:26:0)
[23:50:24.286] Timer tick, asking Buildbucket for the build status
[23:50:24.331] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:24.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:27:0) after 1m0s
[23:51:24.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:27:0)
[23:51:24.405] Timer tick, asking Buildbucket for the build status
[23:51:24.472] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:24.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:28:0) after 1m0s
[23:52:24.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:28:0)
[23:52:24.487] Timer tick, asking Buildbucket for the build status
[23:52:24.600] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:24.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:29:0) after 1m0s
[23:53:24.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:29:0)
[23:53:24.614] Timer tick, asking Buildbucket for the build status
[23:53:24.672] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:24.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:30:0) after 1m0s
[23:54:24.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:30:0)
[23:54:24.694] Timer tick, asking Buildbucket for the build status
[23:54:24.790] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:24.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:31:0) after 1m0s
[23:55:24.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:31:0)
[23:55:24.818] Timer tick, asking Buildbucket for the build status
[23:55:24.887] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:32:0) after 1m0s
[23:56:24.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:32:0)
[23:56:24.905] Timer tick, asking Buildbucket for the build status
[23:56:24.966] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:24.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:33:0) after 1m0s
[23:57:24.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:33:0)
[23:57:24.994] Timer tick, asking Buildbucket for the build status
[23:57:25.053] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:25.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:34:0) after 1m0s
[23:58:25.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:34:0)
[23:58:25.086] Timer tick, asking Buildbucket for the build status
[23:58:25.296] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:25.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:35:0) after 1m0s
[23:59:25.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:35:0)
[23:59:25.375] Timer tick, asking Buildbucket for the build status
[23:59:25.457] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:25.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:36:0) after 1m0s
[00:00:25.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:36:0)
[00:00:25.500] Timer tick, asking Buildbucket for the build status
[00:00:25.613] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:25.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:37:0) after 1m0s
[00:01:25.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:37:0)
[00:01:25.671] Timer tick, asking Buildbucket for the build status
[00:01:26.086] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:26.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:38:0) after 1m0s
[00:02:26.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:38:0)
[00:02:26.106] Timer tick, asking Buildbucket for the build status
[00:02:26.186] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:26.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:39:0) after 1m0s
[00:03:26.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:39:0)
[00:03:26.202] Timer tick, asking Buildbucket for the build status
[00:03:26.273] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:26.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:40:0) after 1m0s
[00:04:26.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:40:0)
[00:04:26.325] Timer tick, asking Buildbucket for the build status
[00:04:26.441] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:26.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:41:0) after 1m0s
[00:05:26.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:41:0)
[00:05:26.458] Timer tick, asking Buildbucket for the build status
[00:05:26.556] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:26.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:42:0) after 1m0s
[00:06:26.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:42:0)
[00:06:26.582] Timer tick, asking Buildbucket for the build status
[00:06:26.673] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:26.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:43:0) after 1m0s
[00:07:26.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:43:0)
[00:07:26.706] Timer tick, asking Buildbucket for the build status
[00:07:26.789] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:26.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:44:0) after 1m0s
[00:08:26.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:44:0)
[00:08:26.810] Timer tick, asking Buildbucket for the build status
[00:08:26.880] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:26.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:45:0) after 1m0s
[00:09:26.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:45:0)
[00:09:26.905] Timer tick, asking Buildbucket for the build status
[00:09:27.284] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:27.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:46:0) after 1m0s
[00:10:27.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:46:0)
[00:10:27.400] Timer tick, asking Buildbucket for the build status
[00:10:27.667] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:27.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:47:0) after 1m0s
[00:11:27.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:47:0)
[00:11:27.742] Timer tick, asking Buildbucket for the build status
[00:11:28.069] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:28.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:48:0) after 1m0s
[00:12:28.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:48:0)
[00:12:28.274] Timer tick, asking Buildbucket for the build status
[00:12:28.465] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:28.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:49:0) after 1m0s
[00:13:28.490] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:49:0)
[00:13:28.490] Timer tick, asking Buildbucket for the build status
[00:13:28.582] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:28.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:50:0) after 1m0s
[00:14:28.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:50:0)
[00:14:28.614] Timer tick, asking Buildbucket for the build status
[00:14:28.690] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:28.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:51:0) after 1m0s
[00:15:28.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:51:0)
[00:15:28.726] Timer tick, asking Buildbucket for the build status
[00:15:28.830] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:28.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:52:0) after 1m0s
[00:16:28.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:52:0)
[00:16:28.960] Timer tick, asking Buildbucket for the build status
[00:16:29.046] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:29.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:53:0) after 1m0s
[00:17:29.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:53:0)
[00:17:29.068] Timer tick, asking Buildbucket for the build status
[00:17:29.135] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:29.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:54:0) after 1m0s
[00:18:29.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:54:0)
[00:18:29.200] Timer tick, asking Buildbucket for the build status
[00:18:29.376] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:29.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:55:0) after 1m0s
[00:19:29.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:55:0)
[00:19:29.515] Timer tick, asking Buildbucket for the build status
[00:19:29.610] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:29.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:56:0) after 1m0s
[00:20:29.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:56:0)
[00:20:29.730] Timer tick, asking Buildbucket for the build status
[00:20:29.795] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:29.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:57:0) after 1m0s
[00:21:29.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:57:0)
[00:21:29.841] Timer tick, asking Buildbucket for the build status
[00:21:29.905] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:29.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:58:0) after 1m0s
[00:22:29.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:58:0)
[00:22:29.969] Timer tick, asking Buildbucket for the build status
[00:22:30.009] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:30.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:59:0) after 1m0s
[00:23:30.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:59:0)
[00:23:30.028] Timer tick, asking Buildbucket for the build status
[00:23:30.093] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:30.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:60:0) after 1m0s
[00:24:30.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:60:0)
[00:24:30.198] Timer tick, asking Buildbucket for the build status
[00:24:30.338] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:30.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:61:0) after 1m0s
[00:25:30.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:61:0)
[00:25:30.355] Timer tick, asking Buildbucket for the build status
[00:25:30.439] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:30.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:62:0) after 1m0s
[00:26:30.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:62:0)
[00:26:30.468] Timer tick, asking Buildbucket for the build status
[00:26:30.530] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:30.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:63:0) after 1m0s
[00:27:30.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:63:0)
[00:27:30.600] Timer tick, asking Buildbucket for the build status
[00:27:30.644] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:30.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:64:0) after 1m0s
[00:28:30.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:64:0)
[00:28:30.693] Timer tick, asking Buildbucket for the build status
[00:28:30.828] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:30.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:65:0) after 1m0s
[00:29:30.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:65:0)
[00:29:30.889] Timer tick, asking Buildbucket for the build status
[00:29:30.962] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:30.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:66:0) after 1m0s
[00:30:31.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:66:0)
[00:30:31.052] Timer tick, asking Buildbucket for the build status
[00:30:31.202] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:31.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:67:0) after 1m0s
[00:31:31.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:67:0)
[00:31:31.290] Timer tick, asking Buildbucket for the build status
[00:31:32.190] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:32.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:68:0) after 1m0s
[00:32:32.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:68:0)
[00:32:32.208] Timer tick, asking Buildbucket for the build status
[00:32:32.582] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:32.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:69:0) after 1m0s
[00:33:32.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:69:0)
[00:33:32.601] Timer tick, asking Buildbucket for the build status
[00:33:32.692] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:32.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:70:0) after 1m0s
[00:34:32.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:70:0)
[00:34:32.712] Timer tick, asking Buildbucket for the build status
[00:34:32.882] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:32.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:71:0) after 1m0s
[00:35:32.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:71:0)
[00:35:32.900] Timer tick, asking Buildbucket for the build status
[00:35:33.195] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:33.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:72:0) after 1m0s
[00:36:33.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:72:0)
[00:36:33.213] Timer tick, asking Buildbucket for the build status
[00:36:33.430] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:33.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:73:0) after 1m0s
[00:37:33.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:73:0)
[00:37:33.509] Timer tick, asking Buildbucket for the build status
[00:37:33.664] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:33.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:74:0) after 1m0s
[00:38:33.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:74:0)
[00:38:33.682] Timer tick, asking Buildbucket for the build status
[00:38:33.906] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:33.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:75:0) after 1m0s
[00:39:33.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:75:0)
[00:39:33.926] Timer tick, asking Buildbucket for the build status
[00:39:34.012] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:34.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:76:0) after 1m0s
[00:40:34.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:76:0)
[00:40:34.032] Timer tick, asking Buildbucket for the build status
[00:40:34.097] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:34.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:77:0) after 1m0s
[00:41:34.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:77:0)
[00:41:34.118] Timer tick, asking Buildbucket for the build status
[00:41:34.186] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:34.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:78:0) after 1m0s
[00:42:34.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:78:0)
[00:42:34.226] Timer tick, asking Buildbucket for the build status
[00:42:34.340] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:34.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:79:0) after 1m0s
[00:43:34.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:79:0)
[00:43:34.364] Timer tick, asking Buildbucket for the build status
[00:43:34.434] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:34.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:80:0) after 1m0s
[00:44:34.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:80:0)
[00:44:34.453] Timer tick, asking Buildbucket for the build status
[00:44:34.511] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:34.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:81:0) after 1m0s
[00:45:34.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:81:0)
[00:45:34.531] Timer tick, asking Buildbucket for the build status
[00:45:34.599] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:34.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:82:0) after 1m0s
[00:46:34.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:82:0)
[00:46:34.621] Timer tick, asking Buildbucket for the build status
[00:46:34.696] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:34.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:83:0) after 1m0s
[00:47:34.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:83:0)
[00:47:34.715] Timer tick, asking Buildbucket for the build status
[00:47:34.753] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:34.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:84:0) after 1m0s
[00:48:34.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:84:0)
[00:48:34.816] Timer tick, asking Buildbucket for the build status
[00:48:34.938] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:34.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:85:0) after 1m0s
[00:49:34.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:85:0)
[00:49:34.958] Timer tick, asking Buildbucket for the build status
[00:49:35.032] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:35.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:86:0) after 1m0s
[00:50:35.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:86:0)
[00:50:35.051] Timer tick, asking Buildbucket for the build status
[00:50:35.115] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:35.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:87:0) after 1m0s
[00:51:35.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:87:0)
[00:51:35.137] Timer tick, asking Buildbucket for the build status
[00:51:35.174] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:35.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:88:0) after 1m0s
[00:52:35.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:88:0)
[00:52:35.196] Timer tick, asking Buildbucket for the build status
[00:52:35.376] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:35.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:89:0) after 1m0s
[00:53:35.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:89:0)
[00:53:35.407] Timer tick, asking Buildbucket for the build status
[00:53:35.470] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:35.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:90:0) after 1m0s
[00:54:35.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:90:0)
[00:54:35.505] Timer tick, asking Buildbucket for the build status
[00:54:35.802] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:35.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:91:0) after 1m0s
[00:55:35.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:91:0)
[00:55:35.821] Timer tick, asking Buildbucket for the build status
[00:55:35.879] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:35.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:92:0) after 1m0s
[00:56:35.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:92:0)
[00:56:35.904] Timer tick, asking Buildbucket for the build status
[00:56:35.987] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:35.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:93:0) after 1m0s
[00:57:36.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:93:0)
[00:57:36.009] Timer tick, asking Buildbucket for the build status
[00:57:36.075] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:36.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:94:0) after 1m0s
[00:58:36.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:94:0)
[00:58:36.095] Timer tick, asking Buildbucket for the build status
[00:58:36.156] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:36.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:95:0) after 1m0s
[00:59:36.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:95:0)
[00:59:36.178] Timer tick, asking Buildbucket for the build status
[00:59:36.258] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:36.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:96:0) after 1m0s
[01:00:36.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:96:0)
[01:00:36.319] Timer tick, asking Buildbucket for the build status
[01:00:36.636] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:36.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:97:0) after 1m0s
[01:01:36.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:97:0)
[01:01:36.657] Timer tick, asking Buildbucket for the build status
[01:01:36.765] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:36.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:98:0) after 1m0s
[01:02:36.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:98:0)
[01:02:36.798] Timer tick, asking Buildbucket for the build status
[01:02:36.889] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:36.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:99:0) after 1m0s
[01:03:36.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:99:0)
[01:03:36.914] Timer tick, asking Buildbucket for the build status
[01:03:36.971] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:36.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:100:0) after 1m0s
[01:04:36.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:100:0)
[01:04:36.991] Timer tick, asking Buildbucket for the build status
[01:04:37.051] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:37.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:101:0) after 1m0s
[01:05:37.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:101:0)
[01:05:37.075] Timer tick, asking Buildbucket for the build status
[01:05:37.224] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:37.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:102:0) after 1m0s
[01:06:37.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:102:0)
[01:06:37.269] Timer tick, asking Buildbucket for the build status
[01:06:37.515] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:37.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:103:0) after 1m0s
[01:07:37.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:103:0)
[01:07:37.536] Timer tick, asking Buildbucket for the build status
[01:07:37.609] Build 8935275804043261792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:37.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100705866325368112:104:0) after 1m0s
[01:08:18.068] Received PubSub notification, asking Buildbucket for the build status
[01:08:18.124] Build 8935275804043261792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:08:18.124] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1537060096954178",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537053977885518",
"id": "8935275804043261792",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"26aad747934718e6a909ded290befdf0408e9355\"}}",
"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/8935275804043261792/+/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\": [\"3772-022cb40\"], \"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\": \"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"26aad747934718e6a909ded290befdf0408e9355\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24746}\", \"$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@{#591595}\", \"branch\": \"refs/heads/master\", \"revision\": \"26aad747934718e6a909ded290befdf0408e9355\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d574123c5035901107e4dd56a3cd0968f174a881\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"62114aae85503437bb4ee1b1efe0d497242f06c4\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1537053977885518, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/26aad747934718e6a909ded290befdf0408e9355\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26aad747934718e6a909ded290befdf0408e9355\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9100705866325368112\", \"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\": \"8935275804043261792\"}}, \"got_v8_revision\": \"d0c0f8f909c828ff93f1d9dec2b9f060f4bc389b\", \"got_v8_revision_cp\": \"refs/heads/7.1.113@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10100, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"d113e9ba6a6b832e15eb18d74aac4479a29e2a8b\", \"notification_helper_unittests\": \"27b2afb026c9f2b569adaa8eed68ad6756d28fd7\", \"gpu_perftests\": \"bc0754ef180653f3e06963b38d71cee8b4676b74\", \"vr_common_unittests\": \"c462de20035a461884158dc798eeed91da5b2f92\", \"telemetry_unittests\": \"79bcb5bcfd1479ac35563a7e4e561924e618a852\", \"load_library_perf_tests\": \"55345345327b37d3cba8c36d1122be1b491289bf\", \"devtools_closure_compile\": \"ddc75b11bce520062ca544b38048c0ee2393d653\", \"chromedriver_py_tests\": \"70bfa295e21f8c04354f5a5b7cec831516bc813b\", \"mojo_core_unittests\": \"9230f52d895d68d422123158002ac2ac35511126\", \"install_static_unittests\": \"a8172bf99218651265fcd4a69492723972dc16d3\", \"leveldb_service_unittests\": \"840568055555425b9120190ad44d969d12cb541a\", \"mini_installer_tests\": \"ce5103c2b8d9bf9d76ee85a00bb5cab57ffc43d2\", \"jingle_unittests\": \"4f79d232450d31635c4d4ad28e639614f716fe16\", \"sbox_integration_tests\": \"2ae80c29dc39a9f72ff64370191ec6eebf52cd0b\", \"angle_unittests\": \"9f4c754e95a7af2259cbb2f01e65c6e40d0122fb\", \"cast_unittests\": \"cfb2b9e144cee343e97214c68bdcc1806689152f\", \"cc_unittests\": \"c3440891c6834b7e264d548c29aedd74aa957608\", \"blink_common_unittests\": \"3cd217749977435b4eaca62a22e31fd59425e510\", \"crashpad_tests\": \"658777352e287a16de870aaacf886a6fb53bf242\", \"telemetry_perf_tests_without_chrome\": \"98ba329dc467dbc3c77d7f4d16d01f80cd2e1f22\", \"metrics_python_tests\": \"a54ccbdcb57a0d4e104d4d9469fa880fb724183b\", \"message_center_unittests\": \"b38f5239916191413d83294fe937fe75d72765c3\", \"ppapi_unittests\": \"69ce44877acc2d730f7995fc289c564dba48400b\", \"extensions_unittests\": \"00a19b8f4cf6898f746afffda052422654ef96a5\", \"gl_unittests_ozone\": \"75c1fe1b139b9d32d3186bad8e21bb23104b2496\", \"app_shell_unittests\": \"e35a8971a5a64b067edddc06e162dbb528cdef61\", \"chrome_app_unittests\": \"2791811f731acc5394f69601633bdec5eb44b22e\", \"gl_unittests\": \"75c1fe1b139b9d32d3186bad8e21bb23104b2496\", \"gcm_unit_tests\": \"4dd13f1bbbffac60a8a08ea0e30fc42987bf2ca0\", \"views_unittests\": \"2589b6ac5b3462112fb71fbb8952deee53fd9332\", \"content_shell_crash_test\": \"7694642201c225c38db30aad3b16546bb3c0503a\", \"ui_base_unittests\": \"979da04e9d95893b64e3ab6edb07a44db09a2b97\", \"gles2_conform_test\": \"398465fd11779d95ac8f67a9d8edaf2e34a610a6\", \"cronet_unittests\": \"14e7c7646bb26d69ef0767839028ae0a9b96ea83\", \"performance_test_suite\": \"5abe57a58f7d3371aa6a9703ac7c93a0b88cd30d\", \"wm_unittests\": \"ce992739cec1648c47e64f38a2ef6c1bc93446e4\", \"boringssl_crypto_tests\": \"9e4f787eab926db80035cf74dcca188b1fcd8116\", \"gin_unittests\": \"eb61067d148b7806e95000cda04ac045aaa20609\", \"performance_browser_tests\": \"ea2401e0e6d28782b7ed98c307623ab365b33a16\", \"extensions_browsertests\": \"fd4b076fc7bad8ff5915557cac44880c218338cc\", \"webkit_python_tests\": \"bbea217519c9c21cb13bc07a67442e6119894493\", \"headless_unittests\": \"66d2f44c74aeea0c3d5339e6187d0975dfd9438f\", \"webkit_layout_tests\": \"cfe57cdb4b762a1d11bbccb55e7b2291223c5822\", \"vr_pixeltests\": \"1157503eb033a918fb161ecc085c94c362026612\", \"setup_unittests\": \"132cca3e217756573a69b186030b0c3d8810fc8f\", \"webkit_unit_tests\": \"f446266d606e68894bd63eefa148bb7ad25a09f7\", \"content_unittests\": \"01ab2e5ffa37befb1425497f9e4e41a85a4e0964\", \"performance_webview_test_suite\": \"b63e01a58b22e6888bbf216abd6b36d560b92eec\", \"wtf_unittests\": \"4545b99a3b26290b82626f4b041a435a3b2e20fe\", \"webkit_layout_tests_exparchive\": \"4f642d3868cc97a237dcbc5fbba0a98cd3f5de07\", \"chrome_cleaner_unittests\": \"2d25a5be04317085a4b3a31f91710ed9244c2d25\", \"traffic_annotation_auditor_unittests\": \"376852bece858f78360c66bcae12e1bae0037545\", \"libjingle_xmpp_unittests\": \"6de2ee7e3600b82c8d813c08e85beae611b9012c\", \"remoting_unittests\": \"dcb00d5e42dc1cc47a550f87a4103427738d59df\", \"vr_common_perftests\": \"dcecd1b5c9496fae2cd3b680791ac6159ffbcc6c\", \"filesystem_service_unittests\": \"5a0c73d445549f869a3948d98000588e6ace429e\", \"chrome_elf_import_unittests\": \"02ed75841d338d2b954f334f39ee95748f75caa4\", \"installer_util_unittests\": \"d61e7b9b6640b2cb42e3a91e52fb3225b4362138\", \"gfx_unittests\": \"1bc048b5718cebd3cfd81f36ca5f660264fea893\", \"headless_browsertests\": \"0487a12acd48a2924457df463a4289a48d430058\", \"capture_unittests\": \"6e0bc9b8f5d6b69d0b8f3d5317260888a225e50e\", \"chrome_elf_unittests\": \"ffb4c92567535ed91bee133fd2d6b3eac59f5571\", \"telemetry_gpu_unittests\": \"6033f9c2462b881b5c7adb989034518956586df6\", \"command_buffer_perftests\": \"e7d33a61b162e835e1a30b3c0ed65a7713a69cc5\", \"media_unittests\": \"dacf4ebb737328dc7786489b0007450217c3e6b4\", \"chromedriver_unittests\": \"a5078424c08c73bcf6cfe3747daf12adfc4f878b\", \"views_mus_interactive_ui_tests\": \"4a33300399fa94527f33d9eaf1bb1333dff220d2\", \"storage_unittests\": \"3d3e596b1b6ccb4f1c4f406f56febde8e274dbf5\", \"media_service_unittests\": \"dc684f2c8bc9a172b4ea362bc9ac2ad502c55b3a\", \"compositor_unittests\": \"375bfc709fcc078c1a7a3340d6ecc68f70d8e534\", \"latency_unittests\": \"620e6386cc0f9b376d219487f2eba08241761669\", \"video_decode_accelerator_unittest\": \"7a0a2a2455f99346f3d1f70b554a0879d12bf7a2\", \"swiftshader_unittests\": \"fae6640405b73244c4cf91e4b79a2d7ef938eed6\", \"telemetry_perf_unittests\": \"a47aa2e1a15a4062b33b88b05859bf63c65bd477\", \"media_blink_unittests\": \"677f98dc5e56d873d8cb3c22d51485bf2f3dd6f8\", \"views_mus_unittests\": \"d7e15d4fd2753087782590e7c692b215f75423da\", \"components_unittests\": \"d096bb6019b84f205bfa9664a92bfe66da3955ff\", \"snapshot_unittests\": \"f6171a0b6f38d694569d7232dc71df3e715df48b\", \"accessibility_unittests\": \"e058256b41bd4c1b206bcc37887c9e989c0abf59\", \"net_perftests\": \"6de74a0c764c0ff77b7a6ff0ec3fdbd27c1f140c\", \"aura_unittests\": \"f23d20fe0677932be3721470170c5710c85d6644\", \"services_unittests\": \"343f21be7997d0c1c3c3f5b1032bdf8b0c46ac93\", \"components_perftests\": \"f74fafff321ab750113db0b0725c2d49332fa77f\", \"events_unittests\": \"eae6f22771640b1b1aa9091f35aae95f82092d0b\", \"tracing_perftests\": \"99c94128ad3ffcdfd0ea8ec56f7797b8c8bfa44c\", \"chromedriver_replay_unittests\": \"b20c79768bc563bc51002fc0b8b68169ffa58104\", \"ui_touch_selection_unittests\": \"9601f244a965dcce39dea2aae012829e84a941fc\", \"cacheinvalidation_unittests\": \"4e371aee7b48af26cc56ab39d89e5d7e36a4e0dd\", \"viz_unittests\": \"ed28c45dd65f307233e68e3d500f7195ab579870\", \"browser_tests\": \"8149379339981b4439f5397ab40e41bdccaa9767\", \"net_unittests\": \"f3a5beb0ae0f260aaf8332d78c13b649ff0e66ad\", \"midi_unittests\": \"34737d81b1457ff42cbd2ee30e05f5dcba4302d7\", \"boringssl_ssl_tests\": \"8f80ae11eaf2f7a5058ca9107f739d873d1c8291\", \"sbox_validation_tests\": \"896cb9f1b02a3f878e1acc73b4380ce2de2c69d3\", \"elevation_service_unittests\": \"5e53d02802b895874d2d2845678e88d0d6041416\", \"gpu_unittests\": \"3b0f4073d88576431364d8800013b82d7dee7967\", \"native_theme_unittests\": \"9f0d8febede6a4dc227f1934d47f0c6b6057b2fc\", \"interactive_ui_tests\": \"617c4539109db1c747181a1a8fd81964bd072eea\", \"mojo_unittests\": \"26a9209e667eac09e9f41bc6a448536d0cbb9eaa\", \"url_unittests\": \"512d4956d1c9368e101db8e690c4f95d1b89bbbb\", \"media_perftests\": \"8444d116573f10c87d770ec7330638333caef32d\", \"cronet_tests\": \"e0a1247e04f0b2ba2b9b5c9ff51dc5d645d6125f\", \"google_apis_unittests\": \"917c33974eef80dbb863ff41adaafeaad1a3a917\", \"telemetry_gpu_integration_test\": \"96e526ac50a1a49a192d6167601d43047b7c99e5\", \"blink_heap_unittests\": \"e809d61a5866f88767fb107ca5a18c5a6027b60f\", \"base_unittests\": \"a000e8016e68058a900a6d6b747eee60e7dfce73\", \"sync_integration_tests\": \"d89750043bc9c6d42bebeb318dd1939fa4d4800f\", \"sql_unittests\": \"751070074017d6658ca4ecf2d7b7779ab7d1cb82\", \"courgette_unittests\": \"fdb02652f05152b6b94b3ddb38e8935580e822dc\", \"blink_fuzzer_unittests\": \"61552b481ee4099762623ca7289d3dd9d22325bc\", \"gl_tests\": \"9ef573a29a144d2ec543cc7a63d8901ef232e6b2\", \"zucchini_unittests\": \"4910d01ce93c8c4d94b35715e23699175cb40f72\", \"ipc_tests\": \"3beeec7556c6de9e1bde6531fca3b531a993a71f\", \"angle_end2end_tests\": \"be8289426e4a2405ac5b1e6c0e73b575aa8e8848\", \"blink_platform_unittests\": \"0e231ae69801513cd7cea2fb64d4a9e13d163ad4\", \"components_browsertests\": \"615ecffc187670cc2e446ea3c54b3bd707f46f28\", \"views_perftests\": \"3db36c2829b1ca4b99c440c1bfbc7b800fd1555b\", \"angle_perftests\": \"b21a2fe9d94e9da810a3a90c69f4a9d2e4c9a0e0\", \"display_unittests\": \"5e4bbdd7ff2f8f5531d3b47cfe4cbea2b0079b44\", \"sbox_unittests\": \"91692baf696063eb8eca72bccbfc02361c930b1f\", \"service_manager_unittests\": \"391ea7eac9d0b41d89619d15a60db0596d034eb4\", \"pdf_unittests\": \"e6328867c5afe1b4559fd2a737c5362b85c1a8e9\", \"skia_unittests\": \"82e0c0d823a78a7769e92fc5b38c96e719a7e746\", \"angle_white_box_tests\": \"8324be17283ba4d8adb658d5aec48a2c3e5f7e1c\", \"crypto_unittests\": \"3ec35057e4dc2c9eb6eccc887f4bf27bf3dac610\", \"nacl_loader_unittests\": \"91d1bba88d969939c3c97230f924e884928c59bd\", \"unit_tests\": \"5e3d9d5a3d1c70eb1915dbdb35be7fa590053c51\", \"content_browsertests\": \"9a903fe8e72aacdcb674adcfe0fc1e8efa8a42a1\", \"printing_unittests\": \"bf33135c88a20ffd0056d793834cec79f7778910\", \"device_unittests\": \"380c4fc611f74d7bbf4ec8807f1141a49c31e37e\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1537053983446386",
"status": "COMPLETED",
"status_changed_ts": "1537060097550646",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10100",
"builder:Windows deterministic",
"buildset:commit/git/26aad747934718e6a909ded290befdf0408e9355",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26aad747934718e6a909ded290befdf0408e9355",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9100705866325368112",
"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/10100",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8935275804043261792",
"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/26aad747934718e6a909ded290befdf0408e9355",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26aad747934718e6a909ded290befdf0408e9355",
"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/8935275804043261792/+/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:9100705866325368112",
"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:1ac7d09cc4a2ea082595b18a4d4396092aef4e9e",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3ff85fffb8661710",
"user_agent:luci-scheduler"
],
"updated_ts": "1537060097552490",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10100",
"utcnow_ts": "1537060098107577"
}
}
[01:08:18.124] Invocation finished in 1h42m1.799498287s with status SUCCEEDED