[01:01:48.286] New invocation is queued and will start shortly
[01:01:49.524] Starting the invocation (attempt 1)
[01:01:49.558] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:01:49.558] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:01:49.559] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9099793886282062832",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9099793886282062832",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"gitiles_ref:refs/heads/master"
]
}
[01:01:50.964] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537923709652405",
"id": "8934363824186456848",
"lease_expiration_ts": "1538067710564365",
"lease_key": "1915871170",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1537923710862212",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10202",
"builder:Windows deterministic",
"buildset:commit/git/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099793886282062832",
"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/10202",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934363824186456848",
"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/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"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/8934363824186456848/+/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:9099793886282062832",
"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:4356a920a8a0ad4859b5e122d61b40789502e42b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:402c3704b8c3b810",
"user_agent:luci-scheduler"
],
"updated_ts": "1537923710862327",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10202",
"utcnow_ts": "1537923710951338"
}
}
[01:01:50.964] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10202
[01:01:50.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:2:0) after 1m0s
[01:01:53.430] Received PubSub notification, asking Buildbucket for the build status
[01:01:53.475] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:50.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:2:0)
[01:02:50.987] Timer tick, asking Buildbucket for the build status
[01:02:51.028] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:51.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:4:0) after 1m0s
[01:03:51.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:4:0)
[01:03:51.047] Timer tick, asking Buildbucket for the build status
[01:03:51.110] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:51.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:5:0) after 1m0s
[01:04:51.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:5:0)
[01:04:51.210] Timer tick, asking Buildbucket for the build status
[01:04:51.274] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:51.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:6:0) after 1m0s
[01:05:51.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:6:0)
[01:05:51.292] Timer tick, asking Buildbucket for the build status
[01:05:51.362] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:51.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:7:0) after 1m0s
[01:06:51.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:7:0)
[01:06:51.425] Timer tick, asking Buildbucket for the build status
[01:06:51.476] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:51.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:8:0) after 1m0s
[01:07:51.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:8:0)
[01:07:51.494] Timer tick, asking Buildbucket for the build status
[01:07:51.554] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:51.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:9:0) after 1m0s
[01:08:51.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:9:0)
[01:08:51.572] Timer tick, asking Buildbucket for the build status
[01:08:51.626] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:51.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:10:0) after 1m0s
[01:09:51.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:10:0)
[01:09:51.650] Timer tick, asking Buildbucket for the build status
[01:09:51.714] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:51.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:11:0) after 1m0s
[01:10:51.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:11:0)
[01:10:51.734] Timer tick, asking Buildbucket for the build status
[01:10:51.925] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:51.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:12:0) after 1m0s
[01:11:51.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:12:0)
[01:11:51.943] Timer tick, asking Buildbucket for the build status
[01:11:51.978] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:51.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:13:0) after 1m0s
[01:12:51.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:13:0)
[01:12:51.993] Timer tick, asking Buildbucket for the build status
[01:12:52.091] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:52.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:14:0) after 1m0s
[01:13:52.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:14:0)
[01:13:52.106] Timer tick, asking Buildbucket for the build status
[01:13:52.145] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:52.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:15:0) after 1m0s
[01:14:52.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:15:0)
[01:14:52.232] Timer tick, asking Buildbucket for the build status
[01:14:52.267] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:52.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:16:0) after 1m0s
[01:15:52.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:16:0)
[01:15:52.285] Timer tick, asking Buildbucket for the build status
[01:15:52.335] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:52.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:17:0) after 1m0s
[01:16:52.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:17:0)
[01:16:52.414] Timer tick, asking Buildbucket for the build status
[01:16:52.486] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:52.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:18:0) after 1m0s
[01:17:52.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:18:0)
[01:17:52.519] Timer tick, asking Buildbucket for the build status
[01:17:52.621] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:52.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:19:0) after 1m0s
[01:18:52.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:19:0)
[01:18:52.648] Timer tick, asking Buildbucket for the build status
[01:18:52.707] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:52.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:20:0) after 1m0s
[01:19:52.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:20:0)
[01:19:52.726] Timer tick, asking Buildbucket for the build status
[01:19:52.818] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:52.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:21:0) after 1m0s
[01:20:52.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:21:0)
[01:20:52.838] Timer tick, asking Buildbucket for the build status
[01:20:52.900] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:52.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:22:0) after 1m0s
[01:21:52.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:22:0)
[01:21:52.921] Timer tick, asking Buildbucket for the build status
[01:21:52.979] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:52.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:23:0) after 1m0s
[01:22:53.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:23:0)
[01:22:53.016] Timer tick, asking Buildbucket for the build status
[01:22:53.087] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:53.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:24:0) after 1m0s
[01:23:53.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:24:0)
[01:23:53.109] Timer tick, asking Buildbucket for the build status
[01:23:53.743] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:53.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:25:0) after 1m0s
[01:24:54.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:25:0)
[01:24:54.113] Timer tick, asking Buildbucket for the build status
[01:24:54.160] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:54.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:26:0) after 1m0s
[01:25:54.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:26:0)
[01:25:54.178] Timer tick, asking Buildbucket for the build status
[01:25:54.209] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:54.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:27:0) after 1m0s
[01:26:54.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:27:0)
[01:26:54.324] Timer tick, asking Buildbucket for the build status
[01:26:54.387] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:54.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:28:0) after 1m0s
[01:27:54.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:28:0)
[01:27:54.474] Timer tick, asking Buildbucket for the build status
[01:27:54.512] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:54.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:29:0) after 1m0s
[01:28:54.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:29:0)
[01:28:54.529] Timer tick, asking Buildbucket for the build status
[01:28:54.591] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:54.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:30:0) after 1m0s
[01:29:54.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:30:0)
[01:29:54.623] Timer tick, asking Buildbucket for the build status
[01:29:54.688] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:54.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:31:0) after 1m0s
[01:30:54.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:31:0)
[01:30:54.708] Timer tick, asking Buildbucket for the build status
[01:30:54.830] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:54.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:32:0) after 1m0s
[01:31:54.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:32:0)
[01:31:54.847] Timer tick, asking Buildbucket for the build status
[01:31:54.903] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:54.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:33:0) after 1m0s
[01:32:55.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:33:0)
[01:32:55.123] Timer tick, asking Buildbucket for the build status
[01:32:55.258] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:55.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:34:0) after 1m0s
[01:33:55.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:34:0)
[01:33:55.278] Timer tick, asking Buildbucket for the build status
[01:33:55.329] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:55.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:35:0) after 1m0s
[01:34:55.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:35:0)
[01:34:55.349] Timer tick, asking Buildbucket for the build status
[01:34:55.433] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:55.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:36:0) after 1m0s
[01:35:55.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:36:0)
[01:35:55.453] Timer tick, asking Buildbucket for the build status
[01:35:55.649] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:55.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:37:0) after 1m0s
[01:36:55.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:37:0)
[01:36:55.669] Timer tick, asking Buildbucket for the build status
[01:36:55.991] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:55.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:38:0) after 1m0s
[01:37:56.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:38:0)
[01:37:56.010] Timer tick, asking Buildbucket for the build status
[01:37:56.056] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:56.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:39:0) after 1m0s
[01:38:56.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:39:0)
[01:38:56.076] Timer tick, asking Buildbucket for the build status
[01:38:56.134] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:56.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:40:0) after 1m0s
[01:39:56.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:40:0)
[01:39:56.159] Timer tick, asking Buildbucket for the build status
[01:39:56.200] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:56.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:41:0) after 1m0s
[01:40:56.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:41:0)
[01:40:56.260] Timer tick, asking Buildbucket for the build status
[01:40:56.485] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:56.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:42:0) after 1m0s
[01:41:56.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:42:0)
[01:41:56.512] Timer tick, asking Buildbucket for the build status
[01:41:56.549] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:56.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:43:0) after 1m0s
[01:42:56.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:43:0)
[01:42:56.573] Timer tick, asking Buildbucket for the build status
[01:42:56.616] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:44:0) after 1m0s
[01:43:56.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:44:0)
[01:43:56.651] Timer tick, asking Buildbucket for the build status
[01:43:56.713] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:56.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:45:0) after 1m0s
[01:44:56.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:45:0)
[01:44:56.810] Timer tick, asking Buildbucket for the build status
[01:44:56.859] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:56.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:46:0) after 1m0s
[01:45:56.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:46:0)
[01:45:56.880] Timer tick, asking Buildbucket for the build status
[01:45:56.918] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:56.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:47:0) after 1m0s
[01:46:56.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:47:0)
[01:46:56.939] Timer tick, asking Buildbucket for the build status
[01:46:57.013] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:57.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:48:0) after 1m0s
[01:47:57.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:48:0)
[01:47:57.035] Timer tick, asking Buildbucket for the build status
[01:47:57.097] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:57.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:49:0) after 1m0s
[01:48:57.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:49:0)
[01:48:57.150] Timer tick, asking Buildbucket for the build status
[01:48:57.222] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:57.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:50:0) after 1m0s
[01:49:57.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:50:0)
[01:49:57.244] Timer tick, asking Buildbucket for the build status
[01:49:57.304] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:57.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:51:0) after 1m0s
[01:50:57.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:51:0)
[01:50:57.323] Timer tick, asking Buildbucket for the build status
[01:50:57.388] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:57.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:52:0) after 1m0s
[01:51:57.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:52:0)
[01:51:57.404] Timer tick, asking Buildbucket for the build status
[01:51:57.440] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:57.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:53:0) after 1m0s
[01:52:57.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:53:0)
[01:52:57.457] Timer tick, asking Buildbucket for the build status
[01:52:58.110] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:58.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:54:0) after 1m0s
[01:53:58.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:54:0)
[01:53:58.139] Timer tick, asking Buildbucket for the build status
[01:53:58.330] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:58.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:55:0) after 1m0s
[01:54:58.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:55:0)
[01:54:58.351] Timer tick, asking Buildbucket for the build status
[01:54:58.398] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:58.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:56:0) after 1m0s
[01:55:58.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:56:0)
[01:55:58.424] Timer tick, asking Buildbucket for the build status
[01:55:58.610] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:58.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:57:0) after 1m0s
[01:56:58.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:57:0)
[01:56:58.728] Timer tick, asking Buildbucket for the build status
[01:56:58.842] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:58.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:58:0) after 1m0s
[01:57:58.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:58:0)
[01:57:58.863] Timer tick, asking Buildbucket for the build status
[01:57:58.898] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:58.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:59:0) after 1m0s
[01:58:59.020] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:59:0)
[01:58:59.020] Timer tick, asking Buildbucket for the build status
[01:58:59.222] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:59.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:60:0) after 1m0s
[01:59:59.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:60:0)
[01:59:59.259] Timer tick, asking Buildbucket for the build status
[01:59:59.311] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:59.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:61:0) after 1m0s
[02:00:59.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:61:0)
[02:00:59.338] Timer tick, asking Buildbucket for the build status
[02:00:59.469] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:59.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:62:0) after 1m0s
[02:01:59.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:62:0)
[02:01:59.493] Timer tick, asking Buildbucket for the build status
[02:01:59.651] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:59.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:63:0) after 1m0s
[02:02:59.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:63:0)
[02:02:59.707] Timer tick, asking Buildbucket for the build status
[02:02:59.782] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:59.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:64:0) after 1m0s
[02:03:59.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:64:0)
[02:03:59.802] Timer tick, asking Buildbucket for the build status
[02:03:59.839] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:59.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:65:0) after 1m0s
[02:04:59.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:65:0)
[02:04:59.865] Timer tick, asking Buildbucket for the build status
[02:04:59.923] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:59.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:66:0) after 1m0s
[02:05:59.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:66:0)
[02:05:59.957] Timer tick, asking Buildbucket for the build status
[02:06:00.010] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:00.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:67:0) after 1m0s
[02:07:00.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:67:0)
[02:07:00.035] Timer tick, asking Buildbucket for the build status
[02:07:00.069] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:00.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:68:0) after 1m0s
[02:08:00.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:68:0)
[02:08:00.096] Timer tick, asking Buildbucket for the build status
[02:08:00.163] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:00.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:69:0) after 1m0s
[02:09:00.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:69:0)
[02:09:00.214] Timer tick, asking Buildbucket for the build status
[02:09:00.268] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:00.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:70:0) after 1m0s
[02:10:00.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:70:0)
[02:10:00.286] Timer tick, asking Buildbucket for the build status
[02:10:00.371] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:00.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:71:0) after 1m0s
[02:11:00.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:71:0)
[02:11:00.418] Timer tick, asking Buildbucket for the build status
[02:11:00.491] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:00.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:72:0) after 1m0s
[02:12:00.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:72:0)
[02:12:00.536] Timer tick, asking Buildbucket for the build status
[02:12:00.601] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:00.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:73:0) after 1m0s
[02:13:00.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:73:0)
[02:13:00.665] Timer tick, asking Buildbucket for the build status
[02:13:00.814] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:00.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:74:0) after 1m0s
[02:14:00.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:74:0)
[02:14:00.851] Timer tick, asking Buildbucket for the build status
[02:14:00.899] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:00.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:75:0) after 1m0s
[02:15:01.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:75:0)
[02:15:01.019] Timer tick, asking Buildbucket for the build status
[02:15:01.155] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:01.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:76:0) after 1m0s
[02:16:01.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:76:0)
[02:16:01.177] Timer tick, asking Buildbucket for the build status
[02:16:01.247] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:01.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:77:0) after 1m0s
[02:17:01.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:77:0)
[02:17:01.318] Timer tick, asking Buildbucket for the build status
[02:17:03.854] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:03.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:78:0) after 1m0s
[02:18:03.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:78:0)
[02:18:03.874] Timer tick, asking Buildbucket for the build status
[02:18:03.933] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:03.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:79:0) after 1m0s
[02:19:03.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:79:0)
[02:19:03.969] Timer tick, asking Buildbucket for the build status
[02:19:04.001] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:04.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:80:0) after 1m0s
[02:20:04.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:80:0)
[02:20:04.051] Timer tick, asking Buildbucket for the build status
[02:20:04.160] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:04.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:81:0) after 1m0s
[02:21:04.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:81:0)
[02:21:04.180] Timer tick, asking Buildbucket for the build status
[02:21:04.265] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:04.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:82:0) after 1m0s
[02:22:04.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:82:0)
[02:22:04.283] Timer tick, asking Buildbucket for the build status
[02:22:04.399] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:04.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:83:0) after 1m0s
[02:23:04.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:83:0)
[02:23:04.416] Timer tick, asking Buildbucket for the build status
[02:23:04.509] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:04.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:84:0) after 1m0s
[02:24:04.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:84:0)
[02:24:04.535] Timer tick, asking Buildbucket for the build status
[02:24:04.625] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:04.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:85:0) after 1m0s
[02:25:04.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:85:0)
[02:25:04.680] Timer tick, asking Buildbucket for the build status
[02:25:04.749] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:04.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:86:0) after 1m0s
[02:26:04.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:86:0)
[02:26:04.859] Timer tick, asking Buildbucket for the build status
[02:26:04.965] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:04.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:87:0) after 1m0s
[02:27:05.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:87:0)
[02:27:05.116] Timer tick, asking Buildbucket for the build status
[02:27:05.216] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:05.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:88:0) after 1m0s
[02:28:05.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:88:0)
[02:28:05.237] Timer tick, asking Buildbucket for the build status
[02:28:05.319] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:05.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:89:0) after 1m0s
[02:29:05.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:89:0)
[02:29:05.348] Timer tick, asking Buildbucket for the build status
[02:29:05.415] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:05.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:90:0) after 1m0s
[02:30:05.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:90:0)
[02:30:05.444] Timer tick, asking Buildbucket for the build status
[02:30:05.488] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:05.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:91:0) after 1m0s
[02:31:05.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:91:0)
[02:31:05.522] Timer tick, asking Buildbucket for the build status
[02:31:05.633] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:05.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:92:0) after 1m0s
[02:32:05.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:92:0)
[02:32:05.653] Timer tick, asking Buildbucket for the build status
[02:32:05.732] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:05.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:93:0) after 1m0s
[02:33:05.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:93:0)
[02:33:05.777] Timer tick, asking Buildbucket for the build status
[02:33:05.892] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:05.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:94:0) after 1m0s
[02:34:06.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:94:0)
[02:34:06.014] Timer tick, asking Buildbucket for the build status
[02:34:06.050] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:06.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:95:0) after 1m0s
[02:35:06.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:95:0)
[02:35:06.076] Timer tick, asking Buildbucket for the build status
[02:35:06.117] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:06.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:96:0) after 1m0s
[02:36:06.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:96:0)
[02:36:06.216] Timer tick, asking Buildbucket for the build status
[02:36:06.310] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:06.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:97:0) after 1m0s
[02:37:06.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:97:0)
[02:37:06.329] Timer tick, asking Buildbucket for the build status
[02:37:06.361] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:06.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:98:0) after 1m0s
[02:38:06.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:98:0)
[02:38:06.397] Timer tick, asking Buildbucket for the build status
[02:38:06.479] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:06.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:99:0) after 1m0s
[02:39:06.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:99:0)
[02:39:06.506] Timer tick, asking Buildbucket for the build status
[02:39:06.594] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:06.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:100:0) after 1m0s
[02:40:06.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:100:0)
[02:40:06.630] Timer tick, asking Buildbucket for the build status
[02:40:06.703] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:06.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:101:0) after 1m0s
[02:41:06.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:101:0)
[02:41:06.729] Timer tick, asking Buildbucket for the build status
[02:41:06.793] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:06.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:102:0) after 1m0s
[02:42:06.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:102:0)
[02:42:06.819] Timer tick, asking Buildbucket for the build status
[02:42:07.185] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:07.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:103:0) after 1m0s
[02:43:07.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:103:0)
[02:43:07.211] Timer tick, asking Buildbucket for the build status
[02:43:07.450] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:07.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:104:0) after 1m0s
[02:44:07.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:104:0)
[02:44:07.472] Timer tick, asking Buildbucket for the build status
[02:44:07.540] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:07.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:105:0) after 1m0s
[02:45:07.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:105:0)
[02:45:07.569] Timer tick, asking Buildbucket for the build status
[02:45:07.696] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:07.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:106:0) after 1m0s
[02:46:07.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:106:0)
[02:46:07.821] Timer tick, asking Buildbucket for the build status
[02:46:07.872] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:07.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:107:0) after 1m0s
[02:47:07.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:107:0)
[02:47:07.965] Timer tick, asking Buildbucket for the build status
[02:47:08.039] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:08.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:108:0) after 1m0s
[02:48:08.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:108:0)
[02:48:08.068] Timer tick, asking Buildbucket for the build status
[02:48:08.213] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:08.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:109:0) after 1m0s
[02:49:08.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:109:0)
[02:49:08.246] Timer tick, asking Buildbucket for the build status
[02:49:08.416] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:08.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:110:0) after 1m0s
[02:50:08.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:110:0)
[02:50:08.439] Timer tick, asking Buildbucket for the build status
[02:50:08.569] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:08.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:111:0) after 1m0s
[02:51:08.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:111:0)
[02:51:08.612] Timer tick, asking Buildbucket for the build status
[02:51:08.649] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:08.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:112:0) after 1m0s
[02:52:08.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:112:0)
[02:52:08.672] Timer tick, asking Buildbucket for the build status
[02:52:08.761] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:08.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:113:0) after 1m0s
[02:53:08.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:113:0)
[02:53:08.801] Timer tick, asking Buildbucket for the build status
[02:53:09.046] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:09.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:114:0) after 1m0s
[02:54:09.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:114:0)
[02:54:09.074] Timer tick, asking Buildbucket for the build status
[02:54:09.116] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:09.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:115:0) after 1m0s
[02:55:09.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:115:0)
[02:55:09.147] Timer tick, asking Buildbucket for the build status
[02:55:09.210] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:09.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:116:0) after 1m0s
[02:56:09.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:116:0)
[02:56:09.235] Timer tick, asking Buildbucket for the build status
[02:56:09.291] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:09.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:117:0) after 1m0s
[02:57:09.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:117:0)
[02:57:09.316] Timer tick, asking Buildbucket for the build status
[02:57:09.388] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:09.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:118:0) after 1m0s
[02:58:09.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:118:0)
[02:58:09.492] Timer tick, asking Buildbucket for the build status
[02:58:09.586] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:09.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:119:0) after 1m0s
[02:59:09.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:119:0)
[02:59:09.665] Timer tick, asking Buildbucket for the build status
[02:59:09.795] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:09.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:120:0) after 1m0s
[03:00:09.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:120:0)
[03:00:09.831] Timer tick, asking Buildbucket for the build status
[03:00:09.926] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:09.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:121:0) after 1m0s
[03:01:09.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:121:0)
[03:01:09.950] Timer tick, asking Buildbucket for the build status
[03:01:10.077] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:10.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:122:0) after 1m0s
[03:02:10.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:122:0)
[03:02:10.132] Timer tick, asking Buildbucket for the build status
[03:02:10.222] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:10.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:123:0) after 1m0s
[03:03:10.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:123:0)
[03:03:10.309] Timer tick, asking Buildbucket for the build status
[03:03:10.361] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:10.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:124:0) after 1m0s
[03:04:10.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:124:0)
[03:04:10.445] Timer tick, asking Buildbucket for the build status
[03:04:10.506] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:10.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:125:0) after 1m0s
[03:05:10.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:125:0)
[03:05:10.532] Timer tick, asking Buildbucket for the build status
[03:05:10.571] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:10.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:126:0) after 1m0s
[03:06:10.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:126:0)
[03:06:10.589] Timer tick, asking Buildbucket for the build status
[03:06:10.686] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:10.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:127:0) after 1m0s
[03:07:10.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:127:0)
[03:07:10.709] Timer tick, asking Buildbucket for the build status
[03:07:10.766] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:10.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:128:0) after 1m0s
[03:08:10.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:128:0)
[03:08:10.803] Timer tick, asking Buildbucket for the build status
[03:08:11.008] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:11.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:129:0) after 1m0s
[03:09:11.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:129:0)
[03:09:11.036] Timer tick, asking Buildbucket for the build status
[03:09:11.141] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:11.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:130:0) after 1m0s
[03:10:11.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:130:0)
[03:10:11.174] Timer tick, asking Buildbucket for the build status
[03:10:11.310] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:11.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:131:0) after 1m0s
[03:11:11.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:131:0)
[03:11:11.332] Timer tick, asking Buildbucket for the build status
[03:11:11.370] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:11.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:132:0) after 1m0s
[03:12:11.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:132:0)
[03:12:11.414] Timer tick, asking Buildbucket for the build status
[03:12:11.472] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:11.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:133:0) after 1m0s
[03:13:11.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:133:0)
[03:13:11.498] Timer tick, asking Buildbucket for the build status
[03:13:11.537] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:11.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:134:0) after 1m0s
[03:14:11.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:134:0)
[03:14:11.561] Timer tick, asking Buildbucket for the build status
[03:14:11.626] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:11.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:135:0) after 1m0s
[03:15:11.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:135:0)
[03:15:11.652] Timer tick, asking Buildbucket for the build status
[03:15:11.716] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:11.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:136:0) after 1m0s
[03:16:11.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:136:0)
[03:16:11.744] Timer tick, asking Buildbucket for the build status
[03:16:11.922] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:11.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:137:0) after 1m0s
[03:17:11.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:137:0)
[03:17:11.956] Timer tick, asking Buildbucket for the build status
[03:17:12.011] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:12.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:138:0) after 1m0s
[03:18:12.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:138:0)
[03:18:12.218] Timer tick, asking Buildbucket for the build status
[03:18:12.315] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:12.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:139:0) after 1m0s
[03:19:12.423] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:139:0)
[03:19:12.423] Timer tick, asking Buildbucket for the build status
[03:19:12.565] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:12.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:140:0) after 1m0s
[03:20:12.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:140:0)
[03:20:12.588] Timer tick, asking Buildbucket for the build status
[03:20:12.646] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:12.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:141:0) after 1m0s
[03:21:12.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:141:0)
[03:21:12.725] Timer tick, asking Buildbucket for the build status
[03:21:12.838] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:12.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:142:0) after 1m0s
[03:22:12.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:142:0)
[03:22:12.881] Timer tick, asking Buildbucket for the build status
[03:22:12.963] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:12.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:143:0) after 1m0s
[03:23:13.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:143:0)
[03:23:13.036] Timer tick, asking Buildbucket for the build status
[03:23:13.133] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:13.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:144:0) after 1m0s
[03:24:13.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:144:0)
[03:24:13.170] Timer tick, asking Buildbucket for the build status
[03:24:13.231] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:13.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:145:0) after 1m0s
[03:25:13.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:145:0)
[03:25:13.262] Timer tick, asking Buildbucket for the build status
[03:25:13.360] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:146:0) after 1m0s
[03:26:13.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:146:0)
[03:26:13.405] Timer tick, asking Buildbucket for the build status
[03:26:13.529] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:13.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:147:0) after 1m0s
[03:27:13.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:147:0)
[03:27:13.550] Timer tick, asking Buildbucket for the build status
[03:27:13.612] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:13.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:148:0) after 1m0s
[03:28:13.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:148:0)
[03:28:13.639] Timer tick, asking Buildbucket for the build status
[03:28:13.953] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:13.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:149:0) after 1m0s
[03:29:13.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:149:0)
[03:29:13.981] Timer tick, asking Buildbucket for the build status
[03:29:14.132] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:14.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:150:0) after 1m0s
[03:30:14.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:150:0)
[03:30:14.155] Timer tick, asking Buildbucket for the build status
[03:30:14.281] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:14.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:151:0) after 1m0s
[03:31:14.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:151:0)
[03:31:14.305] Timer tick, asking Buildbucket for the build status
[03:31:14.514] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:14.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:152:0) after 1m0s
[03:32:14.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:152:0)
[03:32:14.542] Timer tick, asking Buildbucket for the build status
[03:32:14.651] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:14.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:153:0) after 1m0s
[03:33:14.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:153:0)
[03:33:14.674] Timer tick, asking Buildbucket for the build status
[03:33:14.709] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:14.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:154:0) after 1m0s
[03:34:14.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:154:0)
[03:34:14.741] Timer tick, asking Buildbucket for the build status
[03:34:14.939] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:14.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:155:0) after 1m0s
[03:35:14.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:155:0)
[03:35:14.976] Timer tick, asking Buildbucket for the build status
[03:35:15.061] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:15.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:156:0) after 1m0s
[03:36:15.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:156:0)
[03:36:15.115] Timer tick, asking Buildbucket for the build status
[03:36:15.224] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:15.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:157:0) after 1m0s
[03:37:15.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:157:0)
[03:37:15.252] Timer tick, asking Buildbucket for the build status
[03:37:15.292] Build 8934363824186456848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:15.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099793886282062832:158:0) after 1m0s
[03:37:51.422] Received PubSub notification, asking Buildbucket for the build status
[03:37:51.599] Build 8934363824186456848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:37:51.599] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1537933070312325",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537923709652405",
"id": "8934363824186456848",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\"}}",
"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/8934363824186456848/+/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\": [\"3792-6739d67\"], \"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\": \"0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24833}\", \"$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@{#594167}\", \"branch\": \"refs/heads/master\", \"revision\": \"0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"a7af0218826cfed77664e6723470c77089e12db1\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"8b57fae57908d5be0b0c3882d6f1c40b97b3cb56\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1537923709652405, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9099793886282062832\", \"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\": \"8934363824186456848\"}}, \"got_v8_revision\": \"c5a1fcbf544dc5ca5d901e96e2228d1eb767251b\", \"got_v8_revision_cp\": \"refs/heads/7.1.178@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10202, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"f97ec32f15cbe8810d8423a18420b97c640b2373\", \"notification_helper_unittests\": \"7ae40bb7ca915e6941a61027e7c43e0fc67f45a9\", \"gpu_perftests\": \"19a5eb969ab1e535583c49927bc9bc3eb4efcd29\", \"vr_common_unittests\": \"d8249d9983dfa4eb33896d27d0dcb77a87aeec84\", \"telemetry_unittests\": \"13475e73782664a4d927ed3635b641baa00cb8ca\", \"load_library_perf_tests\": \"a12c843c8518101f8be65a8e876630c40500b392\", \"devtools_closure_compile\": \"bcd55c1be9e48a8f10e2e745b1e07b2acd0d6fbe\", \"chromedriver_py_tests\": \"41ca05ba7c62a78f0d884a695718430f8d323b3e\", \"mojo_core_unittests\": \"a8294c28d49de2006fffa4b845280b633f99cf01\", \"install_static_unittests\": \"cabdf64c591fbf2a2e6cdd8415c769b0d0933973\", \"leveldb_service_unittests\": \"0e7d2eb0ebf91f4641e13666c7cc935e21835050\", \"mini_installer_tests\": \"919647ab5d4df1055437b6e8c111008842a029f6\", \"jingle_unittests\": \"5785cfdea62f1b4d785064967a734b7944c71ba7\", \"sbox_integration_tests\": \"8aea57111f572511720d61e428555fa99f8e6102\", \"angle_unittests\": \"dc38d6b5833b25a044112c06cfcd321467eb981a\", \"cast_unittests\": \"54211607a87c400802332fb97de576539bc3696a\", \"cc_unittests\": \"46b25976f1669a8cc03dab6186d4b513c0b4500b\", \"blink_common_unittests\": \"493a85de785dea7d2ababd7dcb39bba201847215\", \"crashpad_tests\": \"591e8bd97095a34272d602e1cf839a3cf326a999\", \"telemetry_perf_tests_without_chrome\": \"4ec05bfea5cbc0bb48c057cd6e3661de6f375650\", \"metrics_python_tests\": \"e95e6ad6e22e16e8380bffda0940094e78415b5f\", \"message_center_unittests\": \"92a074f7d87250d004ce8955d560d7529b240baa\", \"ppapi_unittests\": \"ccc98327e30c9b39d88a1c99f7752903caaea63a\", \"extensions_unittests\": \"ce692e46f3eae933b1fb4871adbb1739571373dd\", \"gl_unittests_ozone\": \"0b1f644bdbabede1a68c135f9a222c6aec6b4f79\", \"app_shell_unittests\": \"9436ac0f658b9de950a2c117c3fb91cae0a44121\", \"chrome_app_unittests\": \"7d40040544fadd9a49c9c180cfb7c20517b69d67\", \"gl_unittests\": \"0b1f644bdbabede1a68c135f9a222c6aec6b4f79\", \"gcm_unit_tests\": \"4d702575774e4f5e2e079ce1aefe1941731c72cc\", \"views_unittests\": \"2515d2f853d80fa6f62a348143ab5e744f4dcf1f\", \"content_shell_crash_test\": \"8de4866dc3b3d9a8a2f3c64246de54e94db5616d\", \"ui_base_unittests\": \"b2996ca71e65bbc6b380fab1b92c2e2157d7abfd\", \"gles2_conform_test\": \"13746e0db447baf0c80b3c90e0e9bbfe4460781d\", \"cronet_unittests\": \"c4a044fafd3d11fb584dd1596b3f45dc968a9cf3\", \"performance_test_suite\": \"bb847bc8f50e2f42f619d149ba3ba3769388cef0\", \"wm_unittests\": \"ffa63bd293481ec0fa07ab4f8569acaa7cf5158d\", \"boringssl_crypto_tests\": \"3b4920595f45f55453a245cfc7506331421cd43d\", \"gin_unittests\": \"e6731ddcb1e30355eaf3badc9b64bfa5e1f588d8\", \"performance_browser_tests\": \"fdec9c8ee11d3cdfb5904ccf7f4bb7df726f366b\", \"extensions_browsertests\": \"5392a6dc980c8d82d48834f6cde1ebaaa44256f0\", \"webkit_python_tests\": \"635c7fc428c9d782b8220c284376e42fcba484bc\", \"headless_unittests\": \"81b8ecfb93847abf51b4d26b1468c77cd081b258\", \"webkit_layout_tests\": \"1c9ab531da7e7af69560226b1affeee845e6419b\", \"vr_pixeltests\": \"8085f014ab362e23f932dea247b1673a7ad9c8d7\", \"setup_unittests\": \"1e9690ccb25846c9a9aeccb9d6c1c7dcb9b6e321\", \"webkit_unit_tests\": \"ebc3af73f1af6169e68aaca3e4d7167d1621030d\", \"content_unittests\": \"82044810f1d2401466fc493d319a7958cfce41ab\", \"performance_webview_test_suite\": \"b25bb30bb5924bc17fa61c43491131fcb20ab482\", \"wtf_unittests\": \"a9e45b6f458d8f2d2c5eb3d8fcaadeb5c96def35\", \"webkit_layout_tests_exparchive\": \"436bf04741099505db06e972fdff87516c6a3a6f\", \"chrome_cleaner_unittests\": \"7c3b37abee2653d2e2b62ff53828ca1c641ab41d\", \"traffic_annotation_auditor_unittests\": \"3c3d1bd41637ec38c48e2784a9b555c1edc4172f\", \"libjingle_xmpp_unittests\": \"27c382a26625b53d90df03305bf851c56a6d6c03\", \"remoting_unittests\": \"62cf7afa549393a31ff69eb91f55f5fc444a10b6\", \"vr_common_perftests\": \"c0f9d443b8173bd1b6a695df1274f2797985c171\", \"filesystem_service_unittests\": \"42e16c381d3a3f5493c2ebb168b2377395a78bb2\", \"chrome_elf_import_unittests\": \"07d567797cb4303bb64c0adf18c1fd8dda86cb99\", \"installer_util_unittests\": \"e04342c333c5803cc3a109788dd15fb6e5429bc0\", \"gfx_unittests\": \"c797e2cf228baf99786a5b5b6c48fc01e92d98fb\", \"headless_browsertests\": \"2c303476d221531b8ff1a1d443876c5c8f8e0f9f\", \"capture_unittests\": \"b2c303bfc12a293f7588be5de32f4a9e146a16a0\", \"chrome_elf_unittests\": \"9d10e93047b52974932c7577025cc8b855953266\", \"telemetry_gpu_unittests\": \"401983d42721fd7d0b94c80d62175ef9c1a487ed\", \"command_buffer_perftests\": \"d0932a45e54b2c986a0d3e3386122f65887f1dfa\", \"media_unittests\": \"05d0d4dec6028d97b101d6a15f9bb6941fda87af\", \"chromedriver_unittests\": \"2a2fae0462a7e6f7949ef8a7806ae83d5db75859\", \"views_mus_interactive_ui_tests\": \"b6625f8055c9bbfcb0f95801c610b0e1d5a65f0b\", \"storage_unittests\": \"89b4d5dfcbc6d5ee8de3edbf86ad18a0ad28fd4f\", \"media_service_unittests\": \"fa4288cfe97037a56856bac638a6cf65399ba723\", \"compositor_unittests\": \"6d3f2d2a76f5d4cbdb413fbd76cbbf1a203f25dd\", \"latency_unittests\": \"36e0fb88a53ca06e0a179b2637e563eda5735642\", \"video_decode_accelerator_unittest\": \"e69e0c67f00c80bf54a05c1a2dc3d56b15db0683\", \"swiftshader_unittests\": \"d7142e0746c94d9359358561fad5f07bfc29330d\", \"telemetry_perf_unittests\": \"f63582befeebfbca668c9e46ea10417ee4044e09\", \"media_blink_unittests\": \"bdf81d18e9115770944d611cffaba4fd0a3dc165\", \"views_mus_unittests\": \"7c8d33d400199ec4c15ac0357a92b159aa27de18\", \"components_unittests\": \"e66d9bbd12e4ada36e7c4e2eb2e14ff52e510909\", \"snapshot_unittests\": \"3b341dcdc4e38f6a8ced8e78ff21084dda821fa1\", \"accessibility_unittests\": \"8607b0d69cb16251805624977a8081b5483b244c\", \"net_perftests\": \"c314486a5e7132aa4193081c6464e435ccf76f26\", \"aura_unittests\": \"9ae403a5a90ce2436601ac2522689c98121259dd\", \"services_unittests\": \"83076bf7faf668db47022eb9983967d6ba836229\", \"components_perftests\": \"22387b2185edcbcea8cb4f3af4739081288fa3df\", \"events_unittests\": \"b833ba8d0388f81a1e4db944b0967178fb08e6f4\", \"tracing_perftests\": \"86b25a1e1bcc127250320c88a18495881f26dbab\", \"chromedriver_replay_unittests\": \"50c6aef6c493544165526b2b516579428eb4b618\", \"ui_touch_selection_unittests\": \"12ae4bd5a9b2cf7e5413551f43a02356596a3f48\", \"cacheinvalidation_unittests\": \"0b14bca2e636629273038b0b7f02a337c217ecc7\", \"viz_unittests\": \"0973031fe32b57de15a5cf80af9945dddd3d2bef\", \"browser_tests\": \"757e1fb0edbcd76e05ba56427284a51dd0c8bb1b\", \"net_unittests\": \"b2227f35218c8a8ef50a3928d40dd2725cfe4a43\", \"midi_unittests\": \"360d0345305846c8f6d548ce2287701aab5b590f\", \"boringssl_ssl_tests\": \"c6d0ff014ff0dd59c54b88d0b41edf042792637b\", \"sbox_validation_tests\": \"bde54183bcfc76d7f47506128d181217ea4af941\", \"elevation_service_unittests\": \"b3c7017851a08e6104ee8045e7c31df5093960b4\", \"gpu_unittests\": \"4fe30c32d533f102fd5caaade67497cc738b0dc1\", \"native_theme_unittests\": \"ff4998dc5625f59def4ac1ca19a567f76371ef20\", \"interactive_ui_tests\": \"e62010ab9db2eb63eff2044c706007137d74b0cd\", \"mojo_unittests\": \"ed4e753269c941902751aeeff4e74fa6cd5c054a\", \"url_unittests\": \"1f429bfbc2ed541aae50488991e751294b2965ca\", \"media_perftests\": \"6d401757a190b7aa0bc4431cd1e65beb37b4dff1\", \"cronet_tests\": \"5c6c3e4f1b3c57e4f09ff1d9d9046b6435863fdd\", \"google_apis_unittests\": \"0cbe6d737c7d0328636d4119ec5dcba018ed9495\", \"telemetry_gpu_integration_test\": \"dc4a1d9f8ecfde5b3b5656117f62fac3e8e389a5\", \"blink_heap_unittests\": \"cf46d5b29e8d604509ebff628a107e543bf9c9f8\", \"base_unittests\": \"cdba04a4c30fc5daaa848c1ab1cedac8d9accf63\", \"sync_integration_tests\": \"503c05b8c473322e15b30bc7022c5b0edb66de76\", \"sql_unittests\": \"52452ba516e3e675dad3ec206c345181ff752a0e\", \"courgette_unittests\": \"da02b1ff1b92e32f89c86bbcad41ed3ce6edb4aa\", \"blink_fuzzer_unittests\": \"bb511e4b6127c2bd6cae319b36a4703aabcb9ba3\", \"gl_tests\": \"397717e348f88f70dae8ad5fe53cdf15b897acf0\", \"zucchini_unittests\": \"aa1c488d6c4994385b180634eebd3e406ff23fdf\", \"ipc_tests\": \"a8ee2887c95e3931d84427470a25fb6838ed5837\", \"angle_end2end_tests\": \"416bd258f25fcbef0c4aef0e80c59c6d7c129b85\", \"blink_platform_unittests\": \"9d3b13455dfd6bd3fdda2496c80a0aa4e133ed5e\", \"components_browsertests\": \"f59ea26ef8759d40bf349f0b1835fb41308147c5\", \"views_perftests\": \"486addc0e62bfcd17d9e3c4a1e7c4e9b53c4dfa7\", \"angle_perftests\": \"8902edd094aff74e1dbb9dedb7a24a0c4d20b64e\", \"display_unittests\": \"1b341b1b865038c0df5ace5092b46876ae159972\", \"sbox_unittests\": \"32d0553853168cc2d5230df486fb3d94a98e986a\", \"service_manager_unittests\": \"d9afcea587c210b7595a8e31a4cbb0bffe313b44\", \"pdf_unittests\": \"8b2904468db0c6982c7548a7512bb7d592ac9d31\", \"skia_unittests\": \"73d29329f77d88e285bcca2660b76708e2ddce92\", \"angle_white_box_tests\": \"56675063f2f37fcd4ee11b11de8c1fa02150d7cc\", \"crypto_unittests\": \"65b3c81f6e9cbd31d6b90d00c5639a9374d3c09b\", \"nacl_loader_unittests\": \"31361b459873f8d5f3eaef9db4e20ba1d49a14bc\", \"unit_tests\": \"e0264ef7db22e0444435708fcc0066de5f21384e\", \"content_browsertests\": \"fb027ac2afe22884a2170d04033df33c49cb658b\", \"printing_unittests\": \"40258c560cf6bed0e862c1652a3552dccadb7efd\", \"device_unittests\": \"25911fd997818866f887f5bbcc78a67667850aa8\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1537923711813536",
"status": "COMPLETED",
"status_changed_ts": "1537933070920723",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10202",
"builder:Windows deterministic",
"buildset:commit/git/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099793886282062832",
"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/10202",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934363824186456848",
"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/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0176dbbf6d9dae1ea01f8a3c96eba95d1c3d1620",
"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/8934363824186456848/+/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:9099793886282062832",
"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:4356a920a8a0ad4859b5e122d61b40789502e42b",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:402c3704b8c3b810",
"user_agent:luci-scheduler"
],
"updated_ts": "1537933070922494",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10202",
"utcnow_ts": "1537933071520716"
}
}
[03:37:51.599] Invocation finished in 2h36m3.329443168s with status SUCCEEDED