[13:45:28.654] New invocation is queued and will start shortly
[13:45:29.901] Starting the invocation (attempt 1)
[13:45:29.938] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:45:29.938] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:45:29.938] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9098839870479515072",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"654c1d6355016f6a089db6986f8864729de316eb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9098839870479515072",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/654c1d6355016f6a089db6986f8864729de316eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/654c1d6355016f6a089db6986f8864729de316eb",
"gitiles_ref:refs/heads/master"
]
}
[13:45:31.358] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538833530018111",
"id": "8933409808386487808",
"lease_expiration_ts": "1538977531042968",
"lease_key": "914044418",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"654c1d6355016f6a089db6986f8864729de316eb\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1538833531259103",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10316",
"builder:Windows deterministic",
"buildset:commit/git/654c1d6355016f6a089db6986f8864729de316eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/654c1d6355016f6a089db6986f8864729de316eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098839870479515072",
"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/10316",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8933409808386487808",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/654c1d6355016f6a089db6986f8864729de316eb",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/654c1d6355016f6a089db6986f8864729de316eb",
"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/8933409808386487808/+/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:9098839870479515072",
"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:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:406271c7564e4a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1538833531259238",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10316",
"utcnow_ts": "1538833531348008"
}
}
[13:45:31.358] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10316
[13:45:31.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:2:0) after 1m0s
[13:45:33.273] Received PubSub notification, asking Buildbucket for the build status
[13:45:33.316] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:31.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:2:0)
[13:46:31.377] Timer tick, asking Buildbucket for the build status
[13:46:31.489] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:31.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:4:0) after 1m0s
[13:47:31.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:4:0)
[13:47:31.568] Timer tick, asking Buildbucket for the build status
[13:47:31.809] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:31.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:5:0) after 1m0s
[13:48:31.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:5:0)
[13:48:31.836] Timer tick, asking Buildbucket for the build status
[13:48:31.954] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:31.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:6:0) after 1m0s
[13:49:31.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:6:0)
[13:49:31.981] Timer tick, asking Buildbucket for the build status
[13:49:32.050] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:32.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:7:0) after 1m0s
[13:50:32.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:7:0)
[13:50:32.085] Timer tick, asking Buildbucket for the build status
[13:50:32.155] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:32.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:8:0) after 1m0s
[13:51:32.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:8:0)
[13:51:32.195] Timer tick, asking Buildbucket for the build status
[13:51:32.290] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:32.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:9:0) after 1m0s
[13:52:32.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:9:0)
[13:52:32.322] Timer tick, asking Buildbucket for the build status
[13:52:32.450] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:32.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:10:0) after 1m0s
[13:53:32.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:10:0)
[13:53:32.472] Timer tick, asking Buildbucket for the build status
[13:53:32.560] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:32.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:11:0) after 1m0s
[13:54:32.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:11:0)
[13:54:32.581] Timer tick, asking Buildbucket for the build status
[13:54:32.661] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:32.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:12:0) after 1m0s
[13:55:32.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:12:0)
[13:55:32.681] Timer tick, asking Buildbucket for the build status
[13:55:32.828] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:32.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:13:0) after 1m0s
[13:56:32.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:13:0)
[13:56:32.878] Timer tick, asking Buildbucket for the build status
[13:56:33.114] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:33.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:14:0) after 1m0s
[13:57:33.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:14:0)
[13:57:33.133] Timer tick, asking Buildbucket for the build status
[13:57:33.266] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:33.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:15:0) after 1m0s
[13:58:33.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:15:0)
[13:58:33.287] Timer tick, asking Buildbucket for the build status
[13:58:33.357] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:33.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:16:0) after 1m0s
[13:59:33.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:16:0)
[13:59:33.374] Timer tick, asking Buildbucket for the build status
[13:59:33.419] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:33.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:17:0) after 1m0s
[14:00:33.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:17:0)
[14:00:33.453] Timer tick, asking Buildbucket for the build status
[14:00:33.631] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:33.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:18:0) after 1m0s
[14:01:33.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:18:0)
[14:01:33.650] Timer tick, asking Buildbucket for the build status
[14:01:33.840] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:33.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:19:0) after 1m0s
[14:02:33.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:19:0)
[14:02:33.875] Timer tick, asking Buildbucket for the build status
[14:02:33.958] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:33.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:20:0) after 1m0s
[14:03:33.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:20:0)
[14:03:33.979] Timer tick, asking Buildbucket for the build status
[14:03:34.131] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:34.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:21:0) after 1m0s
[14:04:34.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:21:0)
[14:04:34.163] Timer tick, asking Buildbucket for the build status
[14:04:34.277] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:34.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:22:0) after 1m0s
[14:05:34.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:22:0)
[14:05:34.296] Timer tick, asking Buildbucket for the build status
[14:05:34.450] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:34.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:23:0) after 1m0s
[14:06:34.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:23:0)
[14:06:34.472] Timer tick, asking Buildbucket for the build status
[14:06:34.861] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:34.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:24:0) after 1m0s
[14:07:34.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:24:0)
[14:07:34.909] Timer tick, asking Buildbucket for the build status
[14:07:34.999] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:34.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:25:0) after 1m0s
[14:08:35.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:25:0)
[14:08:35.017] Timer tick, asking Buildbucket for the build status
[14:08:35.066] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:35.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:26:0) after 1m0s
[14:09:35.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:26:0)
[14:09:35.084] Timer tick, asking Buildbucket for the build status
[14:09:35.144] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:35.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:27:0) after 1m0s
[14:10:35.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:27:0)
[14:10:35.164] Timer tick, asking Buildbucket for the build status
[14:10:35.414] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:35.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:28:0) after 1m0s
[14:11:35.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:28:0)
[14:11:35.433] Timer tick, asking Buildbucket for the build status
[14:11:35.482] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:35.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:29:0) after 1m0s
[14:12:35.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:29:0)
[14:12:35.510] Timer tick, asking Buildbucket for the build status
[14:12:35.725] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:35.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:30:0) after 1m0s
[14:13:35.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:30:0)
[14:13:35.746] Timer tick, asking Buildbucket for the build status
[14:13:36.042] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:36.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:31:0) after 1m0s
[14:14:36.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:31:0)
[14:14:36.070] Timer tick, asking Buildbucket for the build status
[14:14:36.132] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:36.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:32:0) after 1m0s
[14:15:36.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:32:0)
[14:15:36.258] Timer tick, asking Buildbucket for the build status
[14:15:36.332] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:36.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:33:0) after 1m0s
[14:16:36.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:33:0)
[14:16:36.351] Timer tick, asking Buildbucket for the build status
[14:16:36.458] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:36.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:34:0) after 1m0s
[14:17:36.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:34:0)
[14:17:36.524] Timer tick, asking Buildbucket for the build status
[14:17:36.604] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:36.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:35:0) after 1m0s
[14:18:36.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:35:0)
[14:18:36.640] Timer tick, asking Buildbucket for the build status
[14:18:36.940] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:36.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:36:0) after 1m0s
[14:19:36.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:36:0)
[14:19:36.961] Timer tick, asking Buildbucket for the build status
[14:19:37.118] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:37.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:37:0) after 1m0s
[14:20:37.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:37:0)
[14:20:37.287] Timer tick, asking Buildbucket for the build status
[14:20:37.353] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:37.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:38:0) after 1m0s
[14:21:37.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:38:0)
[14:21:37.376] Timer tick, asking Buildbucket for the build status
[14:21:37.470] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:37.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:39:0) after 1m0s
[14:22:37.490] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:39:0)
[14:22:37.490] Timer tick, asking Buildbucket for the build status
[14:22:37.557] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:37.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:40:0) after 1m0s
[14:23:37.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:40:0)
[14:23:37.576] Timer tick, asking Buildbucket for the build status
[14:23:37.678] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:37.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:41:0) after 1m0s
[14:24:37.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:41:0)
[14:24:37.697] Timer tick, asking Buildbucket for the build status
[14:24:37.835] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:37.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:42:0) after 1m0s
[14:25:37.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:42:0)
[14:25:37.853] Timer tick, asking Buildbucket for the build status
[14:25:37.931] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:37.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:43:0) after 1m0s
[14:26:37.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:43:0)
[14:26:37.952] Timer tick, asking Buildbucket for the build status
[14:26:38.047] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:38.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:44:0) after 1m0s
[14:27:38.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:44:0)
[14:27:38.103] Timer tick, asking Buildbucket for the build status
[14:27:38.201] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:38.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:45:0) after 1m0s
[14:28:38.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:45:0)
[14:28:38.266] Timer tick, asking Buildbucket for the build status
[14:28:38.406] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:38.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:46:0) after 1m0s
[14:29:38.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:46:0)
[14:29:38.425] Timer tick, asking Buildbucket for the build status
[14:29:38.526] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:38.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:47:0) after 1m0s
[14:30:38.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:47:0)
[14:30:38.567] Timer tick, asking Buildbucket for the build status
[14:30:39.303] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:39.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:48:0) after 1m0s
[14:31:39.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:48:0)
[14:31:39.324] Timer tick, asking Buildbucket for the build status
[14:31:39.439] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:39.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:49:0) after 1m0s
[14:32:39.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:49:0)
[14:32:39.478] Timer tick, asking Buildbucket for the build status
[14:32:39.685] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:39.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:50:0) after 1m0s
[14:33:39.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:50:0)
[14:33:39.707] Timer tick, asking Buildbucket for the build status
[14:33:39.823] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:39.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:51:0) after 1m0s
[14:34:39.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:51:0)
[14:34:39.858] Timer tick, asking Buildbucket for the build status
[14:34:39.943] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:39.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:52:0) after 1m0s
[14:35:39.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:52:0)
[14:35:39.968] Timer tick, asking Buildbucket for the build status
[14:35:40.042] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:40.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:53:0) after 1m0s
[14:36:40.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:53:0)
[14:36:40.335] Timer tick, asking Buildbucket for the build status
[14:36:40.414] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:40.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:54:0) after 1m0s
[14:37:40.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:54:0)
[14:37:40.886] Timer tick, asking Buildbucket for the build status
[14:37:40.926] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:40.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:55:0) after 1m0s
[14:38:41.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:55:0)
[14:38:41.027] Timer tick, asking Buildbucket for the build status
[14:38:41.135] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:41.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:56:0) after 1m0s
[14:39:41.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:56:0)
[14:39:41.156] Timer tick, asking Buildbucket for the build status
[14:39:41.332] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:41.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:57:0) after 1m0s
[14:40:41.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:57:0)
[14:40:41.357] Timer tick, asking Buildbucket for the build status
[14:40:41.427] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:41.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:58:0) after 1m0s
[14:41:41.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:58:0)
[14:41:41.461] Timer tick, asking Buildbucket for the build status
[14:41:41.503] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:41.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:59:0) after 1m0s
[14:42:41.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:59:0)
[14:42:41.523] Timer tick, asking Buildbucket for the build status
[14:42:41.618] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:41.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:60:0) after 1m0s
[14:43:41.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:60:0)
[14:43:41.640] Timer tick, asking Buildbucket for the build status
[14:43:41.818] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:41.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:61:0) after 1m0s
[14:44:41.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:61:0)
[14:44:41.849] Timer tick, asking Buildbucket for the build status
[14:44:41.967] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:41.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:62:0) after 1m0s
[14:45:42.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:62:0)
[14:45:42.233] Timer tick, asking Buildbucket for the build status
[14:45:42.280] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:42.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:63:0) after 1m0s
[14:46:43.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:63:0)
[14:46:43.109] Timer tick, asking Buildbucket for the build status
[14:46:43.280] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:43.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:64:0) after 1m0s
[14:47:43.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:64:0)
[14:47:43.758] Timer tick, asking Buildbucket for the build status
[14:47:43.864] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:43.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:65:0) after 1m0s
[14:48:43.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:65:0)
[14:48:43.996] Timer tick, asking Buildbucket for the build status
[14:48:44.067] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:44.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:66:0) after 1m0s
[14:49:44.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:66:0)
[14:49:44.095] Timer tick, asking Buildbucket for the build status
[14:49:44.165] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:44.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:67:0) after 1m0s
[14:50:44.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:67:0)
[14:50:44.383] Timer tick, asking Buildbucket for the build status
[14:50:44.556] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:44.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:68:0) after 1m0s
[14:51:44.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:68:0)
[14:51:44.593] Timer tick, asking Buildbucket for the build status
[14:51:44.666] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:44.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:69:0) after 1m0s
[14:52:44.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:69:0)
[14:52:44.686] Timer tick, asking Buildbucket for the build status
[14:52:44.728] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:44.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:70:0) after 1m0s
[14:53:45.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:70:0)
[14:53:45.097] Timer tick, asking Buildbucket for the build status
[14:53:45.399] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:45.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:71:0) after 1m0s
[14:54:45.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:71:0)
[14:54:45.854] Timer tick, asking Buildbucket for the build status
[14:54:45.930] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:45.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:72:0) after 1m0s
[14:55:46.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:72:0)
[14:55:46.330] Timer tick, asking Buildbucket for the build status
[14:55:46.384] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:46.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:73:0) after 1m0s
[14:56:46.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:73:0)
[14:56:46.415] Timer tick, asking Buildbucket for the build status
[14:56:46.502] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:46.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:74:0) after 1m0s
[14:57:46.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:74:0)
[14:57:46.528] Timer tick, asking Buildbucket for the build status
[14:57:46.594] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:46.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:75:0) after 1m0s
[14:58:46.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:75:0)
[14:58:46.615] Timer tick, asking Buildbucket for the build status
[14:58:46.672] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:76:0) after 1m0s
[14:59:46.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:76:0)
[14:59:46.734] Timer tick, asking Buildbucket for the build status
[14:59:46.815] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:46.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:77:0) after 1m0s
[15:00:47.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:77:0)
[15:00:47.098] Timer tick, asking Buildbucket for the build status
[15:00:47.272] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:47.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:78:0) after 1m0s
[15:01:47.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:78:0)
[15:01:47.758] Timer tick, asking Buildbucket for the build status
[15:01:47.808] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:47.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:79:0) after 1m0s
[15:02:47.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:79:0)
[15:02:47.830] Timer tick, asking Buildbucket for the build status
[15:02:47.895] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:47.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:80:0) after 1m0s
[15:03:47.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:80:0)
[15:03:47.932] Timer tick, asking Buildbucket for the build status
[15:03:48.023] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:48.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:81:0) after 1m0s
[15:04:48.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:81:0)
[15:04:48.047] Timer tick, asking Buildbucket for the build status
[15:04:48.110] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:48.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:82:0) after 1m0s
[15:05:48.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:82:0)
[15:05:48.132] Timer tick, asking Buildbucket for the build status
[15:05:48.917] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:48.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:83:0) after 1m0s
[15:06:48.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:83:0)
[15:06:48.987] Timer tick, asking Buildbucket for the build status
[15:06:49.301] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:49.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:84:0) after 1m0s
[15:07:49.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:84:0)
[15:07:49.424] Timer tick, asking Buildbucket for the build status
[15:07:49.560] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:49.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:85:0) after 1m0s
[15:08:50.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:85:0)
[15:08:50.242] Timer tick, asking Buildbucket for the build status
[15:08:50.314] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:50.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:86:0) after 1m0s
[15:09:50.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:86:0)
[15:09:50.797] Timer tick, asking Buildbucket for the build status
[15:09:50.970] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:50.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:87:0) after 1m0s
[15:10:52.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:87:0)
[15:10:52.029] Timer tick, asking Buildbucket for the build status
[15:10:52.161] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:52.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:88:0) after 1m0s
[15:11:52.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:88:0)
[15:11:52.186] Timer tick, asking Buildbucket for the build status
[15:11:52.329] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:52.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:89:0) after 1m0s
[15:12:52.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:89:0)
[15:12:52.348] Timer tick, asking Buildbucket for the build status
[15:12:52.464] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:52.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:90:0) after 1m0s
[15:13:52.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:90:0)
[15:13:52.975] Timer tick, asking Buildbucket for the build status
[15:13:53.101] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:53.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:91:0) after 1m0s
[15:14:53.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:91:0)
[15:14:53.535] Timer tick, asking Buildbucket for the build status
[15:14:53.605] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:53.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:92:0) after 1m0s
[15:15:54.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:92:0)
[15:15:54.866] Timer tick, asking Buildbucket for the build status
[15:15:54.931] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:54.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:93:0) after 1m0s
[15:16:55.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:93:0)
[15:16:55.483] Timer tick, asking Buildbucket for the build status
[15:16:55.649] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:55.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:94:0) after 1m0s
[15:17:56.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:94:0)
[15:17:56.034] Timer tick, asking Buildbucket for the build status
[15:17:56.068] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:56.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:95:0) after 1m0s
[15:18:56.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:95:0)
[15:18:56.998] Timer tick, asking Buildbucket for the build status
[15:18:57.077] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:57.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:96:0) after 1m0s
[15:19:57.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:96:0)
[15:19:57.446] Timer tick, asking Buildbucket for the build status
[15:19:57.653] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:57.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:97:0) after 1m0s
[15:20:58.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:97:0)
[15:20:58.006] Timer tick, asking Buildbucket for the build status
[15:20:58.075] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:58.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:98:0) after 1m0s
[15:21:58.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:98:0)
[15:21:58.095] Timer tick, asking Buildbucket for the build status
[15:21:58.187] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:58.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:99:0) after 1m0s
[15:22:58.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:99:0)
[15:22:58.784] Timer tick, asking Buildbucket for the build status
[15:22:58.837] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:58.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:100:0) after 1m0s
[15:23:59.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:100:0)
[15:23:59.438] Timer tick, asking Buildbucket for the build status
[15:23:59.514] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:59.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:101:0) after 1m0s
[15:24:59.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:101:0)
[15:24:59.622] Timer tick, asking Buildbucket for the build status
[15:24:59.810] Build 8933409808386487808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:59.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098839870479515072:102:0) after 1m0s
[15:25:20.621] Received PubSub notification, asking Buildbucket for the build status
[15:25:20.678] Build 8933409808386487808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:25:20.678] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1538839519623335",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538833530018111",
"id": "8933409808386487808",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"654c1d6355016f6a089db6986f8864729de316eb\"}}",
"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/8933409808386487808/+/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\": [\"3801-8761768\"], \"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\": \"2ebbdab4bfb1ed9dfe52ce756b34829207dbe25f\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"654c1d6355016f6a089db6986f8864729de316eb\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25030}\", \"$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@{#597429}\", \"branch\": \"refs/heads/master\", \"revision\": \"654c1d6355016f6a089db6986f8864729de316eb\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"e53341c1dc6ebf11fc879dfe914a0eb31c29ca7c\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"450bf36f7918d18f3186be8ce570d9eac63b309d\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1538833530018111, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/654c1d6355016f6a089db6986f8864729de316eb\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/654c1d6355016f6a089db6986f8864729de316eb\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9098839870479515072\", \"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\": \"8933409808386487808\"}}, \"got_v8_revision\": \"21250057ab11b1d00b290d4044551c8c38eaff7b\", \"got_v8_revision_cp\": \"refs/heads/7.1.274@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10316, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"2a41e18f4ecd620e16c8f2c3bb21f2c7014f60e9\", \"notification_helper_unittests\": \"4dd9e29500ee018f4e38e0ec81ba68910e8cf063\", \"gpu_perftests\": \"160b58c0da90fee83aff4caaebc20be323b8862b\", \"vr_common_unittests\": \"ef5e4888576b37fccbdf71d5236d7a7267359f90\", \"telemetry_unittests\": \"ec63d3c34afb3b6a6174548bd7bc1c7e83a2823b\", \"load_library_perf_tests\": \"7b5f68a450f018c5c6ec5a0555916684e334b573\", \"devtools_closure_compile\": \"947ceeb4ceaa909d325ac331beebc7cb1b6ac0a7\", \"chromedriver_py_tests\": \"fe5ccf6b590cfb1a9b63778a7334ef8758464246\", \"mojo_core_unittests\": \"2e41cce0117970fe692237d7dcf6a29d308bbeab\", \"install_static_unittests\": \"2764fefbfcdd127190771d78535f772b72274f26\", \"leveldb_service_unittests\": \"40e61c80617a2223105c36b5f49dd16aa7a5ad66\", \"mini_installer_tests\": \"9e50e804e52c7849f8d02bccbd29488dcb324c4e\", \"jingle_unittests\": \"f1c3b870bd143996b092a1656591b9dc1be7e5aa\", \"sbox_integration_tests\": \"8c1c1c5376dc16d23fd3195d3d49b1a25172f74c\", \"angle_unittests\": \"fdb4facbe3943a6e18c603100d56dc0bbbfd1333\", \"cast_unittests\": \"0b9d676156ab1c4ccd1a95f9950e75c81862895c\", \"cc_unittests\": \"209e74c04f00c6eef19c49097822fed260c39914\", \"blink_common_unittests\": \"9cb93d0321fcbca091ddcc692886d25a0e9d15c9\", \"crashpad_tests\": \"f48764fdb3ad7cd7a7b17608ab088b55b2c50d06\", \"telemetry_perf_tests_without_chrome\": \"b3318a77beac4b05364fd9d98eb7bc85e867e67a\", \"metrics_python_tests\": \"b4e4090d7c42df6b958c4a40710412bed7ee9ad6\", \"message_center_unittests\": \"e22c412fa703a8e7269a2b7d5200b34353bc7b6f\", \"ppapi_unittests\": \"af4adeb0c0d262e1dba036adb0ccce4876e95af3\", \"extensions_unittests\": \"c739f1276b16b321f8a70cdf6c175b76289ba2a6\", \"gl_unittests_ozone\": \"0cfd76a3e1f0d76197409a03085137a4c252315b\", \"app_shell_unittests\": \"62205fb701e08c7d961b29d048f7a27e616d9849\", \"chrome_app_unittests\": \"6fb947094a8d0ffc3220df57a09ca2aa28a83a45\", \"gl_unittests\": \"0cfd76a3e1f0d76197409a03085137a4c252315b\", \"gcm_unit_tests\": \"8a045c4ad1bffbb57869112ccf80994ec051ce09\", \"views_unittests\": \"521f8a9630e53ea5e3aed8b7facc6b9ae2759c23\", \"content_shell_crash_test\": \"4fbb983a760c4114998f7bb0a44b1877b706c9b8\", \"ui_base_unittests\": \"49f50804397b4cd317bb87c444adc2aa258e8739\", \"gles2_conform_test\": \"a7a6cfba9dfbd5055445b1c94e523bb685e3d47e\", \"cronet_unittests\": \"17ba04d2dc5d71893a775caef0d857a91ba4b207\", \"performance_test_suite\": \"ebba67be19253b7679d7fe44b31547c7b540d6ff\", \"wm_unittests\": \"e668c40c2226d07c19f260557ad98278c4a0c8c0\", \"boringssl_crypto_tests\": \"76b00aa8b78058f21ddd777e5fc991a9f7faf440\", \"gin_unittests\": \"c63b53601f52f34f12b684d6f02733a1644a1720\", \"performance_browser_tests\": \"a2ac7a1d19548d4aa5fbea13ee0ff3e2046878d6\", \"extensions_browsertests\": \"47499b27dd1be5d5c327fb8d88ec62bc049f33a7\", \"webkit_python_tests\": \"1182026ac5ebb0aa298541a05a56d3d287256f41\", \"headless_unittests\": \"acf50f35b9fe9371d430dec0b00e4b1c3aea05fe\", \"webkit_layout_tests\": \"fc092906893281a822060eb0b05d6ca2f0e693fc\", \"vr_pixeltests\": \"c766b40eb237b0bdf30e6a8ab37af1555f6e7ea4\", \"setup_unittests\": \"fd2000c7aa987293a627d640b3c9978ac30e8184\", \"webkit_unit_tests\": \"74ee54bd99086cdc834c7c1802def639d3a148fb\", \"content_unittests\": \"20c9d34e73119e00aaa851e54c0eac16dc8a8ec0\", \"performance_webview_test_suite\": \"d3d48f8a463d1f4783122e472f0291ccdfbe43fb\", \"wtf_unittests\": \"adea6a8727c5e6a904230e12b634d19691bb8a04\", \"webkit_layout_tests_exparchive\": \"1a476e8ce76d4ea13b15789fed46b69cc8249021\", \"chrome_cleaner_unittests\": \"53ef20b5a44bce933c3c876585ace39132c6ea7a\", \"traffic_annotation_auditor_unittests\": \"8f616183037e13e45d0da0dbc13bdd0d1f031279\", \"libjingle_xmpp_unittests\": \"5243e0023cc94931975d8a1048e63f1e19eb20ad\", \"remoting_unittests\": \"912bced9de6d5efc07a700e4c69a494351adea76\", \"vr_common_perftests\": \"3849d52dccc8ed66297edd2af70afb0630dfbbb2\", \"filesystem_service_unittests\": \"41d97b8acd4c80a5326eadd1e453617324424f63\", \"chrome_elf_import_unittests\": \"f8be2c8f06a7d1f19f81dd19a174d66b2de9d6b5\", \"installer_util_unittests\": \"dda475ed8b771bcf1c054c0e299612537d5c1b53\", \"gfx_unittests\": \"1b8eb37297e1507bb3afc7c7cd639e620525c97c\", \"headless_browsertests\": \"1c7b37188b0d92e5aabf70eef78f9c9ab00b3346\", \"capture_unittests\": \"4a37f1ad3a64ee909add2b0f385d7af81e5e1732\", \"chrome_elf_unittests\": \"9b95eab0807d5e75f286d5522868dd848949ac5d\", \"telemetry_gpu_unittests\": \"74deb9a1eacc0a042f05d8bc40d1ee07a6fc879d\", \"command_buffer_perftests\": \"cf4b36f95e1080b5fdc74ae9c7d442357c52414a\", \"media_unittests\": \"24e0d3335b42dea7b46470f55e461b942ee20739\", \"chromedriver_unittests\": \"feb1590a31175f1d36afc7dea9d7a02468f194a9\", \"views_mus_interactive_ui_tests\": \"47c9a5dc8a72f52745a807aef7fd61f9b1ac8332\", \"storage_unittests\": \"d6077c80bf9cb15abf5a7918f218bbfce7e04e09\", \"media_service_unittests\": \"fb41b1b1c1b18b81d9dcfbcbe48a697137e7d28f\", \"compositor_unittests\": \"ab60b2544bf7e4acc8df712c2323d2520e765dcd\", \"latency_unittests\": \"bd12e78de8383d5f332ce5d1b061603fd60b28ac\", \"video_decode_accelerator_unittest\": \"38f029eddb78d7f378aa106c0efc02a8ee7dd9f8\", \"swiftshader_unittests\": \"5d7fddbc688528b7f4c07ebd04fc2e61773d1829\", \"telemetry_perf_unittests\": \"9618181bf692ac8da312e85f35e66cc0e881e0fb\", \"media_blink_unittests\": \"b9ec6a69274d74112cba2cd267b5be0fe3d41940\", \"views_mus_unittests\": \"8d1b1ccb7f12ff06ec46a095858c202adb7c8132\", \"components_unittests\": \"a56c93af4b27edd52a069b0ede40560cff6556fe\", \"snapshot_unittests\": \"54d02b7b1e42ad4649c9f4c3553d86c809313731\", \"accessibility_unittests\": \"0072e40fef83e6cc2b59d802adb425adea04df05\", \"net_perftests\": \"fa0089b46db055bdf4e25c7fa4e0800abaa0911c\", \"aura_unittests\": \"ce68e0fb15a54ec8739eded2acfcb9da28df4e7e\", \"services_unittests\": \"4da0e0db1ac93f17fb323e9a33cb04930f2c5525\", \"components_perftests\": \"b4826012939f6984fc36f8623b81ce6c558dde18\", \"events_unittests\": \"748e6d39ed369ee94b18c6cd782e009757052cca\", \"tracing_perftests\": \"adb32e69723867aa1f257ae85d17e8aad864bfba\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"2a851f2f03f6f558ac611742029dfb6918d28890\", \"cacheinvalidation_unittests\": \"abe6765495f6b4a7a28bd6c064941c4127771e4d\", \"viz_unittests\": \"bfdd70f94d428edd511347ea28520d20b93a47d0\", \"browser_tests\": \"baea34f79fca514e83bd3bddfa31a00310864150\", \"net_unittests\": \"f27a7be0b6737c998734f2e7a9f1df8e797ba4e6\", \"midi_unittests\": \"31e585719d714b50806a2148d3ee191e8d46e0f2\", \"boringssl_ssl_tests\": \"04a7c75a795271bcf061f279bd666ca2e87e74a5\", \"sbox_validation_tests\": \"69ac120f79c78f51972058640fb5b4d217762f86\", \"elevation_service_unittests\": \"a4ae392dc1b5c53792db7380f1809059bfac59fd\", \"gpu_unittests\": \"30f6b0106e888d4233b1fc9a598c0109d7634e30\", \"native_theme_unittests\": \"ed00408cc55944221f538c9af3a75ade6cfdbb7a\", \"interactive_ui_tests\": \"7cdaaa6ad5a4fbaba36cfe9abae805a4cfb652b6\", \"mojo_unittests\": \"b5dd206bcc42cc3eee2f2e5827ead0d9d48ca861\", \"url_unittests\": \"0040fd56aeee8bf440880b665f2bbd9525ee4a64\", \"media_perftests\": \"0443b40fc4f87d5fed0b5e9a8a20f20f2c2336b9\", \"cronet_tests\": \"33493cfb3fc5b8dcf6a432b09c2e1020e3aee076\", \"google_apis_unittests\": \"46d0b4e5ba70471a58960e6491a6e780061eea8f\", \"telemetry_gpu_integration_test\": \"67f50ea0c65f0b9fa298fed93fb4890281747104\", \"blink_heap_unittests\": \"a8db3a8674f151e745b83fd626cd6f46d91bedcd\", \"base_unittests\": \"a581a8c3498df7252d51af08d0b4a9a48907b258\", \"sync_integration_tests\": \"74fa1fc6850f9cb9ab37a3b188b9814929a7652d\", \"sql_unittests\": \"0badaff5a06e6e3956974729ce35b1960d55faec\", \"courgette_unittests\": \"b0b685f3602093638ab944e10dc0bb170c1f5144\", \"blink_fuzzer_unittests\": \"38a449b8e60944dae1683d3fd26b2381c511e052\", \"gl_tests\": \"cd66fc8ad85544d82849e015d4cf567dd8517d99\", \"zucchini_unittests\": \"c8a85a4e06570b0bb0689510c28479f8f3424615\", \"ipc_tests\": \"1cd12a80ce476a167f58ec611a0c2c8ca178dd07\", \"angle_end2end_tests\": \"9042135d1666db3e6dacdca67fe5987ecd5aac9a\", \"blink_platform_unittests\": \"43ece710238d8b002dd05cda1918cb893aa8aa34\", \"components_browsertests\": \"5971eeaaf2f7c27a89c8761d74bdc3a38d2dd59e\", \"views_perftests\": \"babc18b0bab47f8d377ad59443187a5788e10266\", \"angle_perftests\": \"04ab3288c69aad103e1948f85f1a6337b5b995ce\", \"display_unittests\": \"1b8fd6ece5c2c055d384ee6178d3ec2440ca6cf3\", \"sbox_unittests\": \"108659137e672b3c7182355d009b76f9999182d5\", \"service_manager_unittests\": \"5a79fc2a9213f92ff9c6f27d08d9d96dad1a08c0\", \"pdf_unittests\": \"e0fc2758331c89621a12e67ccde95fd9e8d518c5\", \"skia_unittests\": \"352425939224f8f0529d7656da7705d916e034dc\", \"angle_white_box_tests\": \"0eb176a27cccb49efab8ef1d82221d746b85356a\", \"crypto_unittests\": \"d12d2e9e29559748b18d0f28925b03474c16ba48\", \"nacl_loader_unittests\": \"43b6471fad65cc5e89e676958e7473b064489e94\", \"unit_tests\": \"dd7941bbd6cf3d390d5cd2d85256a506c1fc5f7d\", \"content_browsertests\": \"4443f565e8b29783a67e6dd9a563e63a990607aa\", \"printing_unittests\": \"1ab8f6d1279ca80450ac563824ddece58b2593d6\", \"device_unittests\": \"60f1bf7137afe531601228237d4456e4592bc66a\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1538833532251074",
"status": "COMPLETED",
"status_changed_ts": "1538839520146580",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10316",
"builder:Windows deterministic",
"buildset:commit/git/654c1d6355016f6a089db6986f8864729de316eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/654c1d6355016f6a089db6986f8864729de316eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098839870479515072",
"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/10316",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8933409808386487808",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/654c1d6355016f6a089db6986f8864729de316eb",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/654c1d6355016f6a089db6986f8864729de316eb",
"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/8933409808386487808/+/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:9098839870479515072",
"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:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:406271c7564e4a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1538839520148176",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10316",
"utcnow_ts": "1538839520661395"
}
}
[15:25:20.678] Invocation finished in 1h39m52.039293452s with status SUCCEEDED