[23:03:16.500] New invocation is queued and will start shortly
[23:03:17.846] Starting the invocation (attempt 1)
[23:03:17.892] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:03:17.892] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:03:17.892] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9092100601391767024",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1f634278ab6782379bf7045d4c268cabe3ea18ea\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9092100601391767024",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"gitiles_ref:refs/heads/master"
]
}
[23:03:19.766] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1545260598018572",
"id": "8926670539130839136",
"lease_expiration_ts": "1545379399273179",
"lease_key": "1499985118",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1f634278ab6782379bf7045d4c268cabe3ea18ea\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1545260599619248",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/11191",
"builder:Windows deterministic",
"buildset:commit/git/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092100601391767024",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/11191",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8926670539130839136",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/8926670539130839136/+/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:9092100601391767024",
"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:5014e112f146383905281d0ee56d11f26a82422b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41e1870ef85e1d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1545260599619310",
"url": "https://ci.chromium.org/b/8926670539130839136",
"utcnow_ts": "1545260599750505"
}
}
[23:03:19.766] Task URL: https://ci.chromium.org/b/8926670539130839136
[23:03:19.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:2:0) after 1m0s
[23:04:19.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:2:0)
[23:04:19.786] Timer tick, asking Buildbucket for the build status
[23:04:19.922] Build 8926670539130839136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:19.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:3:0) after 1m0s
[23:05:12.087] Received PubSub notification, asking Buildbucket for the build status
[23:05:12.235] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:19.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:3:0)
[23:05:19.942] Timer tick, asking Buildbucket for the build status
[23:05:19.982] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:19.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:5:0) after 1m0s
[23:06:20.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:5:0)
[23:06:20.003] Timer tick, asking Buildbucket for the build status
[23:06:20.141] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:20.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:6:0) after 1m0s
[23:07:20.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:6:0)
[23:07:20.176] Timer tick, asking Buildbucket for the build status
[23:07:20.240] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:20.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:7:0) after 1m0s
[23:08:20.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:7:0)
[23:08:20.263] Timer tick, asking Buildbucket for the build status
[23:08:20.295] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:20.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:8:0) after 1m0s
[23:09:20.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:8:0)
[23:09:20.319] Timer tick, asking Buildbucket for the build status
[23:09:20.357] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:20.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:9:0) after 1m0s
[23:10:20.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:9:0)
[23:10:20.379] Timer tick, asking Buildbucket for the build status
[23:10:20.508] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:20.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:10:0) after 1m0s
[23:11:20.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:10:0)
[23:11:20.551] Timer tick, asking Buildbucket for the build status
[23:11:20.671] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:20.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:11:0) after 1m0s
[23:12:20.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:11:0)
[23:12:20.689] Timer tick, asking Buildbucket for the build status
[23:12:20.865] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:20.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:12:0) after 1m0s
[23:13:20.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:12:0)
[23:13:20.885] Timer tick, asking Buildbucket for the build status
[23:13:20.918] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:20.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:13:0) after 1m0s
[23:14:20.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:13:0)
[23:14:20.951] Timer tick, asking Buildbucket for the build status
[23:14:21.051] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:21.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:14:0) after 1m0s
[23:15:21.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:14:0)
[23:15:21.088] Timer tick, asking Buildbucket for the build status
[23:15:21.268] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:21.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:15:0) after 1m0s
[23:16:21.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:15:0)
[23:16:21.290] Timer tick, asking Buildbucket for the build status
[23:16:21.357] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:21.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:16:0) after 1m0s
[23:17:21.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:16:0)
[23:17:21.376] Timer tick, asking Buildbucket for the build status
[23:17:21.459] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:21.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:17:0) after 1m0s
[23:18:21.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:17:0)
[23:18:21.475] Timer tick, asking Buildbucket for the build status
[23:18:21.504] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:21.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:18:0) after 1m0s
[23:19:21.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:18:0)
[23:19:21.526] Timer tick, asking Buildbucket for the build status
[23:19:21.711] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:21.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:19:0) after 1m0s
[23:20:21.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:19:0)
[23:20:21.730] Timer tick, asking Buildbucket for the build status
[23:20:21.822] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:21.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:20:0) after 1m0s
[23:21:21.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:20:0)
[23:21:21.867] Timer tick, asking Buildbucket for the build status
[23:21:21.903] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:21.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:21:0) after 1m0s
[23:22:22.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:21:0)
[23:22:22.016] Timer tick, asking Buildbucket for the build status
[23:22:22.178] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:22.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:22:0) after 1m0s
[23:23:22.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:22:0)
[23:23:22.197] Timer tick, asking Buildbucket for the build status
[23:23:22.381] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:22.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:23:0) after 1m0s
[23:24:22.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:23:0)
[23:24:22.400] Timer tick, asking Buildbucket for the build status
[23:24:22.466] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:22.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:24:0) after 1m0s
[23:25:22.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:24:0)
[23:25:22.483] Timer tick, asking Buildbucket for the build status
[23:25:22.544] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:25:0) after 1m0s
[23:26:22.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:25:0)
[23:26:22.566] Timer tick, asking Buildbucket for the build status
[23:26:22.652] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:22.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:26:0) after 1m0s
[23:27:22.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:26:0)
[23:27:22.679] Timer tick, asking Buildbucket for the build status
[23:27:22.732] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:22.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:27:0) after 1m0s
[23:28:22.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:27:0)
[23:28:22.756] Timer tick, asking Buildbucket for the build status
[23:28:22.831] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:22.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:28:0) after 1m0s
[23:29:22.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:28:0)
[23:29:22.852] Timer tick, asking Buildbucket for the build status
[23:29:22.912] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:22.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:29:0) after 1m0s
[23:30:22.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:29:0)
[23:30:22.931] Timer tick, asking Buildbucket for the build status
[23:30:22.984] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:22.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:30:0) after 1m0s
[23:31:23.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:30:0)
[23:31:23.006] Timer tick, asking Buildbucket for the build status
[23:31:23.068] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:23.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:31:0) after 1m0s
[23:32:23.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:31:0)
[23:32:23.088] Timer tick, asking Buildbucket for the build status
[23:32:23.190] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:23.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:32:0) after 1m0s
[23:33:23.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:32:0)
[23:33:23.210] Timer tick, asking Buildbucket for the build status
[23:33:23.242] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:23.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:33:0) after 1m0s
[23:34:23.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:33:0)
[23:34:23.261] Timer tick, asking Buildbucket for the build status
[23:34:23.344] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:23.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:34:0) after 1m0s
[23:35:23.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:34:0)
[23:35:23.365] Timer tick, asking Buildbucket for the build status
[23:35:23.444] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:23.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:35:0) after 1m0s
[23:36:23.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:35:0)
[23:36:23.517] Timer tick, asking Buildbucket for the build status
[23:36:23.805] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:23.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:36:0) after 1m0s
[23:37:23.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:36:0)
[23:37:23.823] Timer tick, asking Buildbucket for the build status
[23:37:23.857] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:37:0) after 1m0s
[23:38:23.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:37:0)
[23:38:23.875] Timer tick, asking Buildbucket for the build status
[23:38:23.934] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:23.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:38:0) after 1m0s
[23:39:24.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:38:0)
[23:39:24.000] Timer tick, asking Buildbucket for the build status
[23:39:24.266] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:24.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:39:0) after 1m0s
[23:40:24.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:39:0)
[23:40:24.285] Timer tick, asking Buildbucket for the build status
[23:40:24.344] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:24.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:40:0) after 1m0s
[23:41:24.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:40:0)
[23:41:24.367] Timer tick, asking Buildbucket for the build status
[23:41:24.539] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:24.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:41:0) after 1m0s
[23:42:24.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:41:0)
[23:42:24.563] Timer tick, asking Buildbucket for the build status
[23:42:24.618] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:24.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:42:0) after 1m0s
[23:43:24.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:42:0)
[23:43:24.642] Timer tick, asking Buildbucket for the build status
[23:43:24.721] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:24.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:43:0) after 1m0s
[23:44:24.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:43:0)
[23:44:24.745] Timer tick, asking Buildbucket for the build status
[23:44:24.847] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:24.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:44:0) after 1m0s
[23:45:24.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:44:0)
[23:45:24.941] Timer tick, asking Buildbucket for the build status
[23:45:25.167] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:25.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:45:0) after 1m0s
[23:46:25.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:45:0)
[23:46:25.198] Timer tick, asking Buildbucket for the build status
[23:46:25.369] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:25.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:46:0) after 1m0s
[23:47:25.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:46:0)
[23:47:25.432] Timer tick, asking Buildbucket for the build status
[23:47:25.562] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:25.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:47:0) after 1m0s
[23:48:25.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:47:0)
[23:48:25.591] Timer tick, asking Buildbucket for the build status
[23:48:25.653] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:25.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:48:0) after 1m0s
[23:49:25.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:48:0)
[23:49:25.676] Timer tick, asking Buildbucket for the build status
[23:49:25.754] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:25.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:49:0) after 1m0s
[23:50:25.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:49:0)
[23:50:25.800] Timer tick, asking Buildbucket for the build status
[23:50:25.939] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:25.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:50:0) after 1m0s
[23:51:25.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:50:0)
[23:51:25.961] Timer tick, asking Buildbucket for the build status
[23:51:26.008] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:26.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:51:0) after 1m0s
[23:52:26.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:51:0)
[23:52:26.035] Timer tick, asking Buildbucket for the build status
[23:52:26.072] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:26.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:52:0) after 1m0s
[23:53:26.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:52:0)
[23:53:26.107] Timer tick, asking Buildbucket for the build status
[23:53:26.311] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:26.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:53:0) after 1m0s
[23:54:26.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:53:0)
[23:54:26.329] Timer tick, asking Buildbucket for the build status
[23:54:26.447] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:26.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:54:0) after 1m0s
[23:55:26.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:54:0)
[23:55:26.466] Timer tick, asking Buildbucket for the build status
[23:55:26.512] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:26.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:55:0) after 1m0s
[23:56:26.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:55:0)
[23:56:26.537] Timer tick, asking Buildbucket for the build status
[23:56:26.597] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:26.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:56:0) after 1m0s
[23:57:26.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:56:0)
[23:57:26.615] Timer tick, asking Buildbucket for the build status
[23:57:26.738] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:26.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:57:0) after 1m0s
[23:58:26.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:57:0)
[23:58:26.760] Timer tick, asking Buildbucket for the build status
[23:58:26.916] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:26.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:58:0) after 1m0s
[23:59:26.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:58:0)
[23:59:26.947] Timer tick, asking Buildbucket for the build status
[23:59:26.981] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:26.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:59:0) after 1m0s
[00:00:27.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:59:0)
[00:00:27.074] Timer tick, asking Buildbucket for the build status
[00:00:27.132] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:27.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:60:0) after 1m0s
[00:01:27.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:60:0)
[00:01:27.172] Timer tick, asking Buildbucket for the build status
[00:01:27.215] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:27.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:61:0) after 1m0s
[00:02:27.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:61:0)
[00:02:27.237] Timer tick, asking Buildbucket for the build status
[00:02:27.542] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:27.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:62:0) after 1m0s
[00:03:27.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:62:0)
[00:03:27.572] Timer tick, asking Buildbucket for the build status
[00:03:27.859] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:27.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:63:0) after 1m0s
[00:04:27.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:63:0)
[00:04:27.879] Timer tick, asking Buildbucket for the build status
[00:04:28.067] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:28.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:64:0) after 1m0s
[00:05:28.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:64:0)
[00:05:28.109] Timer tick, asking Buildbucket for the build status
[00:05:28.230] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:28.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:65:0) after 1m0s
[00:06:28.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:65:0)
[00:06:28.292] Timer tick, asking Buildbucket for the build status
[00:06:28.382] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:28.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:66:0) after 1m0s
[00:07:28.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:66:0)
[00:07:28.403] Timer tick, asking Buildbucket for the build status
[00:07:28.537] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:28.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:67:0) after 1m0s
[00:08:28.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:67:0)
[00:08:28.563] Timer tick, asking Buildbucket for the build status
[00:08:28.716] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:28.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:68:0) after 1m0s
[00:09:28.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:68:0)
[00:09:28.765] Timer tick, asking Buildbucket for the build status
[00:09:28.864] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:28.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:69:0) after 1m0s
[00:10:28.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:69:0)
[00:10:28.939] Timer tick, asking Buildbucket for the build status
[00:10:29.008] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:29.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:70:0) after 1m0s
[00:11:29.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:70:0)
[00:11:29.104] Timer tick, asking Buildbucket for the build status
[00:11:29.153] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:29.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:71:0) after 1m0s
[00:12:29.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:71:0)
[00:12:29.192] Timer tick, asking Buildbucket for the build status
[00:12:29.259] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:29.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:72:0) after 1m0s
[00:13:29.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:72:0)
[00:13:29.323] Timer tick, asking Buildbucket for the build status
[00:13:29.360] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:29.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:73:0) after 1m0s
[00:14:29.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:73:0)
[00:14:29.391] Timer tick, asking Buildbucket for the build status
[00:14:29.464] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:29.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:74:0) after 1m0s
[00:15:29.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:74:0)
[00:15:29.495] Timer tick, asking Buildbucket for the build status
[00:15:29.547] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:29.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:75:0) after 1m0s
[00:16:29.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:75:0)
[00:16:29.598] Timer tick, asking Buildbucket for the build status
[00:16:29.696] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:29.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:76:0) after 1m0s
[00:17:29.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:76:0)
[00:17:29.716] Timer tick, asking Buildbucket for the build status
[00:17:29.796] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:29.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:77:0) after 1m0s
[00:18:29.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:77:0)
[00:18:29.820] Timer tick, asking Buildbucket for the build status
[00:18:29.916] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:29.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:78:0) after 1m0s
[00:19:29.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:78:0)
[00:19:29.940] Timer tick, asking Buildbucket for the build status
[00:19:29.973] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:29.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:79:0) after 1m0s
[00:20:29.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:79:0)
[00:20:29.983] Timer tick, asking Buildbucket for the build status
[00:20:30.055] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:30.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:80:0) after 1m0s
[00:21:30.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:80:0)
[00:21:30.079] Timer tick, asking Buildbucket for the build status
[00:21:30.148] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:30.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:81:0) after 1m0s
[00:22:30.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:81:0)
[00:22:30.173] Timer tick, asking Buildbucket for the build status
[00:22:30.272] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:30.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:82:0) after 1m0s
[00:23:30.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:82:0)
[00:23:30.350] Timer tick, asking Buildbucket for the build status
[00:23:30.391] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:30.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:83:0) after 1m0s
[00:24:30.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:83:0)
[00:24:30.443] Timer tick, asking Buildbucket for the build status
[00:24:30.503] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:30.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:84:0) after 1m0s
[00:25:30.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:84:0)
[00:25:30.619] Timer tick, asking Buildbucket for the build status
[00:25:30.672] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:30.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:85:0) after 1m0s
[00:26:30.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:85:0)
[00:26:30.712] Timer tick, asking Buildbucket for the build status
[00:26:30.810] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:30.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:86:0) after 1m0s
[00:27:30.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:86:0)
[00:27:30.814] Timer tick, asking Buildbucket for the build status
[00:27:30.887] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:30.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:87:0) after 1m0s
[00:28:30.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:87:0)
[00:28:30.916] Timer tick, asking Buildbucket for the build status
[00:28:31.032] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:31.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:88:0) after 1m0s
[00:29:31.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:88:0)
[00:29:31.123] Timer tick, asking Buildbucket for the build status
[00:29:31.195] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:31.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:89:0) after 1m0s
[00:30:31.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:89:0)
[00:30:31.216] Timer tick, asking Buildbucket for the build status
[00:30:31.289] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:31.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:90:0) after 1m0s
[00:31:31.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:90:0)
[00:31:31.274] Timer tick, asking Buildbucket for the build status
[00:31:31.314] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:31.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:91:0) after 1m0s
[00:32:31.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:91:0)
[00:32:31.335] Timer tick, asking Buildbucket for the build status
[00:32:31.399] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:31.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:92:0) after 1m0s
[00:33:31.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:92:0)
[00:33:31.485] Timer tick, asking Buildbucket for the build status
[00:33:31.559] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:31.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:93:0) after 1m0s
[00:34:31.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:93:0)
[00:34:31.584] Timer tick, asking Buildbucket for the build status
[00:34:31.661] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:31.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:94:0) after 1m0s
[00:35:31.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:94:0)
[00:35:31.701] Timer tick, asking Buildbucket for the build status
[00:35:31.780] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:31.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:95:0) after 1m0s
[00:36:31.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:95:0)
[00:36:31.840] Timer tick, asking Buildbucket for the build status
[00:36:31.929] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:31.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:96:0) after 1m0s
[00:37:31.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:96:0)
[00:37:31.949] Timer tick, asking Buildbucket for the build status
[00:37:32.070] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:32.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:97:0) after 1m0s
[00:38:32.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:97:0)
[00:38:32.093] Timer tick, asking Buildbucket for the build status
[00:38:32.134] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:32.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:98:0) after 1m0s
[00:39:32.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:98:0)
[00:39:32.168] Timer tick, asking Buildbucket for the build status
[00:39:32.204] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:32.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:99:0) after 1m0s
[00:40:32.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:99:0)
[00:40:32.227] Timer tick, asking Buildbucket for the build status
[00:40:32.363] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:32.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:100:0) after 1m0s
[00:41:32.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:100:0)
[00:41:32.389] Timer tick, asking Buildbucket for the build status
[00:41:32.448] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:32.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:101:0) after 1m0s
[00:42:32.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:101:0)
[00:42:32.470] Timer tick, asking Buildbucket for the build status
[00:42:32.570] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:32.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:102:0) after 1m0s
[00:43:32.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:102:0)
[00:43:32.592] Timer tick, asking Buildbucket for the build status
[00:43:32.657] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:32.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:103:0) after 1m0s
[00:44:32.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:103:0)
[00:44:32.684] Timer tick, asking Buildbucket for the build status
[00:44:32.757] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:32.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:104:0) after 1m0s
[00:45:32.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:104:0)
[00:45:32.782] Timer tick, asking Buildbucket for the build status
[00:45:32.836] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:32.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:105:0) after 1m0s
[00:46:32.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:105:0)
[00:46:32.862] Timer tick, asking Buildbucket for the build status
[00:46:32.939] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:32.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:106:0) after 1m0s
[00:47:32.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:106:0)
[00:47:32.959] Timer tick, asking Buildbucket for the build status
[00:47:33.019] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:33.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:107:0) after 1m0s
[00:48:33.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:107:0)
[00:48:33.044] Timer tick, asking Buildbucket for the build status
[00:48:33.096] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:33.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:108:0) after 1m0s
[00:49:33.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:108:0)
[00:49:33.115] Timer tick, asking Buildbucket for the build status
[00:49:33.179] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:33.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:109:0) after 1m0s
[00:50:33.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:109:0)
[00:50:33.220] Timer tick, asking Buildbucket for the build status
[00:50:33.286] Build 8926670539130839136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:33.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9092100601391767024:110:0) after 1m0s
[00:50:51.770] Received PubSub notification, asking Buildbucket for the build status
[00:50:51.805] Build 8926670539130839136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:50:51.805] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1545267050834810",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1545260598018572",
"id": "8926670539130839136",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1f634278ab6782379bf7045d4c268cabe3ea18ea\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"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\"], \"id\": [\"swarm2173-c4\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3945-402d3be\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"1e2123822ca7424ac63ecdf241af0da87d3ec740\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"1f634278ab6782379bf7045d4c268cabe3ea18ea\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"2745f37875fb0a78e984d9f379df3c493d62613c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26058}\", \"$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@{#617994}\", \"branch\": \"refs/heads/master\", \"revision\": \"1f634278ab6782379bf7045d4c268cabe3ea18ea\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"3f651d80a0fef2de054fc0785d4809cd5dbdf084\", \"mastername\": \"chromium.win\", \"got_angle_revision\": \"ffda3e2985f18f4ff6e3778af8b9715109b21ad0\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1545260598018572, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/1f634278ab6782379bf7045d4c268cabe3ea18ea\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f634278ab6782379bf7045d4c268cabe3ea18ea\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9092100601391767024\", \"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\": \"8926670539130839136\"}}, \"got_v8_revision\": \"4e7096d6ea3c939b38d232ea03b8efd84a0bdc0b\", \"got_v8_revision_cp\": \"refs/heads/7.3.205@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 11191, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"7d88270de197ebe8b439ab5eb57a4a2a0bb810e0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1545260711052660",
"status": "COMPLETED",
"status_changed_ts": "1545267051417807",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/11191",
"builder:Windows deterministic",
"buildset:commit/git/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092100601391767024",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/11191",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8926670539130839136",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f634278ab6782379bf7045d4c268cabe3ea18ea",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_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/8926670539130839136/+/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:9092100601391767024",
"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:5014e112f146383905281d0ee56d11f26a82422b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41e1870ef85e1d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1545267051418929",
"url": "https://ci.chromium.org/b/8926670539130839136",
"utcnow_ts": "1545267051795496"
}
}
[00:50:51.805] Invocation finished in 1h47m35.327648475s with status SUCCEEDED