[05:30:22.921] New invocation is queued and will start shortly
[05:30:24.001] Starting the invocation (attempt 1)
[05:30:24.034] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:30:24.034] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:30:24.034] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030742100465694688",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030742100465694688",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79",
"gitiles_ref:refs/heads/master"
]
}
[05:30:26.018] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603776624199826",
"id": "8865312038462077088",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603776625662680",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42300",
"builder:linux-chromeos-rel",
"buildset:commit/git/d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030742100465694688",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865312038462077088/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1603776625663350",
"url": "https://ci.chromium.org/b/8865312038462077088",
"utcnow_ts": "1603776625998945"
}
}
[05:30:26.018] Task URL: https://ci.chromium.org/b/8865312038462077088
[05:30:26.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:2:0) after 1m0s
[05:30:37.753] Received PubSub notification, asking Buildbucket for the build status
[05:30:37.870] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:26.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:2:0)
[05:31:26.179] Timer tick, asking Buildbucket for the build status
[05:31:26.328] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:26.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:4:0) after 1m0s
[05:32:26.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:4:0)
[05:32:26.479] Timer tick, asking Buildbucket for the build status
[05:32:26.560] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:5:0) after 1m0s
[05:33:26.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:5:0)
[05:33:26.730] Timer tick, asking Buildbucket for the build status
[05:33:26.821] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:6:0) after 1m0s
[05:34:26.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:6:0)
[05:34:26.840] Timer tick, asking Buildbucket for the build status
[05:34:27.288] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:27.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:7:0) after 1m0s
[05:35:27.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:7:0)
[05:35:27.400] Timer tick, asking Buildbucket for the build status
[05:35:27.588] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:8:0) after 1m0s
[05:36:27.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:8:0)
[05:36:27.594] Timer tick, asking Buildbucket for the build status
[05:36:27.762] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:9:0) after 1m0s
[05:37:27.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:9:0)
[05:37:27.963] Timer tick, asking Buildbucket for the build status
[05:37:28.039] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:28.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:10:0) after 1m0s
[05:38:28.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:10:0)
[05:38:28.058] Timer tick, asking Buildbucket for the build status
[05:38:28.250] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:28.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:11:0) after 1m0s
[05:39:28.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:11:0)
[05:39:28.270] Timer tick, asking Buildbucket for the build status
[05:39:28.342] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:12:0) after 1m0s
[05:40:28.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:12:0)
[05:40:28.399] Timer tick, asking Buildbucket for the build status
[05:40:28.591] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:13:0) after 1m0s
[05:41:28.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:13:0)
[05:41:28.626] Timer tick, asking Buildbucket for the build status
[05:41:28.682] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:28.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:14:0) after 1m0s
[05:42:28.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:14:0)
[05:42:28.746] Timer tick, asking Buildbucket for the build status
[05:42:28.823] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:28.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:15:0) after 1m0s
[05:43:28.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:15:0)
[05:43:28.996] Timer tick, asking Buildbucket for the build status
[05:43:29.070] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:29.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:16:0) after 1m0s
[05:44:29.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:16:0)
[05:44:29.112] Timer tick, asking Buildbucket for the build status
[05:44:29.171] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:17:0) after 1m0s
[05:45:29.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:17:0)
[05:45:29.252] Timer tick, asking Buildbucket for the build status
[05:45:29.396] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:29.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:18:0) after 1m0s
[05:46:29.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:18:0)
[05:46:29.416] Timer tick, asking Buildbucket for the build status
[05:46:29.624] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:29.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:19:0) after 1m0s
[05:47:29.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:19:0)
[05:47:29.626] Timer tick, asking Buildbucket for the build status
[05:47:29.695] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:29.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:20:0) after 1m0s
[05:48:29.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:20:0)
[05:48:29.791] Timer tick, asking Buildbucket for the build status
[05:48:30.153] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:30.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:21:0) after 1m0s
[05:49:30.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:21:0)
[05:49:30.173] Timer tick, asking Buildbucket for the build status
[05:49:30.255] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:30.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:22:0) after 1m0s
[05:50:30.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:22:0)
[05:50:30.285] Timer tick, asking Buildbucket for the build status
[05:50:30.398] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:30.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:23:0) after 1m0s
[05:51:30.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:23:0)
[05:51:30.421] Timer tick, asking Buildbucket for the build status
[05:51:30.521] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:30.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:24:0) after 1m0s
[05:52:30.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:24:0)
[05:52:30.578] Timer tick, asking Buildbucket for the build status
[05:52:30.656] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:30.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:25:0) after 1m0s
[05:53:30.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:25:0)
[05:53:30.749] Timer tick, asking Buildbucket for the build status
[05:53:30.936] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:30.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:26:0) after 1m0s
[05:54:31.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:26:0)
[05:54:31.025] Timer tick, asking Buildbucket for the build status
[05:54:31.105] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:31.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:27:0) after 1m0s
[05:55:31.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:27:0)
[05:55:31.148] Timer tick, asking Buildbucket for the build status
[05:55:31.499] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:31.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:28:0) after 1m0s
[05:56:31.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:28:0)
[05:56:31.594] Timer tick, asking Buildbucket for the build status
[05:56:31.796] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:31.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:29:0) after 1m0s
[05:57:31.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:29:0)
[05:57:31.924] Timer tick, asking Buildbucket for the build status
[05:57:31.982] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:31.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:30:0) after 1m0s
[05:58:32.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:30:0)
[05:58:32.108] Timer tick, asking Buildbucket for the build status
[05:58:32.172] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:32.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:31:0) after 1m0s
[05:59:32.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:31:0)
[05:59:32.266] Timer tick, asking Buildbucket for the build status
[05:59:32.683] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:32.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:32:0) after 1m0s
[06:00:32.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:32:0)
[06:00:32.811] Timer tick, asking Buildbucket for the build status
[06:00:33.059] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:33.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:33:0) after 1m0s
[06:01:36.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:33:0)
[06:01:36.857] Timer tick, asking Buildbucket for the build status
[06:01:36.962] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:36.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:34:0) after 1m0s
[06:02:37.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:34:0)
[06:02:37.058] Timer tick, asking Buildbucket for the build status
[06:02:37.160] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:37.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:35:0) after 1m0s
[06:03:37.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:35:0)
[06:03:37.197] Timer tick, asking Buildbucket for the build status
[06:03:37.336] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:37.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:36:0) after 1m0s
[06:04:37.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:36:0)
[06:04:37.346] Timer tick, asking Buildbucket for the build status
[06:04:37.533] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:37.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:37:0) after 1m0s
[06:05:37.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:37:0)
[06:05:37.631] Timer tick, asking Buildbucket for the build status
[06:05:37.787] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:37.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:38:0) after 1m0s
[06:06:37.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:38:0)
[06:06:37.914] Timer tick, asking Buildbucket for the build status
[06:06:38.112] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:38.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:39:0) after 1m0s
[06:07:38.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:39:0)
[06:07:38.142] Timer tick, asking Buildbucket for the build status
[06:07:38.276] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:38.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:40:0) after 1m0s
[06:08:38.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:40:0)
[06:08:38.301] Timer tick, asking Buildbucket for the build status
[06:08:38.374] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:38.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:41:0) after 1m0s
[06:09:38.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:41:0)
[06:09:38.498] Timer tick, asking Buildbucket for the build status
[06:09:38.762] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:38.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:42:0) after 1m0s
[06:10:38.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:42:0)
[06:10:38.883] Timer tick, asking Buildbucket for the build status
[06:10:39.006] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:39.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:43:0) after 1m0s
[06:11:39.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:43:0)
[06:11:39.033] Timer tick, asking Buildbucket for the build status
[06:11:39.149] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:39.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:44:0) after 1m0s
[06:12:39.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:44:0)
[06:12:39.215] Timer tick, asking Buildbucket for the build status
[06:12:39.327] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:39.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:45:0) after 1m0s
[06:13:39.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:45:0)
[06:13:39.409] Timer tick, asking Buildbucket for the build status
[06:13:39.660] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:39.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:46:0) after 1m0s
[06:14:39.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:46:0)
[06:14:39.764] Timer tick, asking Buildbucket for the build status
[06:14:40.069] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:40.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:47:0) after 1m0s
[06:15:40.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:47:0)
[06:15:40.243] Timer tick, asking Buildbucket for the build status
[06:15:40.448] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:40.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:48:0) after 1m0s
[06:16:40.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:48:0)
[06:16:40.509] Timer tick, asking Buildbucket for the build status
[06:16:40.648] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:40.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:49:0) after 1m0s
[06:17:40.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:49:0)
[06:17:40.674] Timer tick, asking Buildbucket for the build status
[06:17:40.984] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:40.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:50:0) after 1m0s
[06:18:41.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:50:0)
[06:18:41.117] Timer tick, asking Buildbucket for the build status
[06:18:41.242] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:41.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:51:0) after 1m0s
[06:19:41.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:51:0)
[06:19:41.332] Timer tick, asking Buildbucket for the build status
[06:19:41.555] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:41.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:52:0) after 1m0s
[06:20:41.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:52:0)
[06:20:41.659] Timer tick, asking Buildbucket for the build status
[06:20:41.781] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:41.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:53:0) after 1m0s
[06:21:41.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:53:0)
[06:21:41.810] Timer tick, asking Buildbucket for the build status
[06:21:41.920] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:41.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:54:0) after 1m0s
[06:22:41.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:54:0)
[06:22:41.980] Timer tick, asking Buildbucket for the build status
[06:22:42.174] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:42.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:55:0) after 1m0s
[06:23:42.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:55:0)
[06:23:42.269] Timer tick, asking Buildbucket for the build status
[06:23:42.408] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:42.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:56:0) after 1m0s
[06:24:42.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:56:0)
[06:24:42.473] Timer tick, asking Buildbucket for the build status
[06:24:43.074] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:43.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:57:0) after 1m0s
[06:25:43.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:57:0)
[06:25:43.289] Timer tick, asking Buildbucket for the build status
[06:25:43.817] Build 8865312038462077088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:43.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030742100465694688:58:0) after 1m0s
[06:26:27.698] Received PubSub notification, asking Buildbucket for the build status
[06:26:27.782] Build 8865312038462077088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:26:27.782] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603779986903385",
"created_by": "project:chromium",
"created_ts": "1603776624199826",
"id": "8865312038462077088",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-61-durd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42300, \"got_angle_revision\": \"b5ba693316fdd5e680f2bb4cf1a2f9bed589d8e2\", \"got_dawn_revision\": \"41c24933da1e6c5ec111f824bfc5977be244d3e4\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79\", \"got_revision_cp\": \"refs/heads/master@{#821092}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"af722073314e07138cd3ef04751dc7ce1035219c\", \"got_v8_revision_cp\": \"refs/heads/8.8.178@{#1}\", \"got_webrtc_revision\": \"0fb0eb3e80c09e0483c4dccdaa472e7e81f182fe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32491}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79\", \"swarm_hashes_refs/heads/master(at){#821092}_without_patch\": {\"absl_hardening_tests\": \"f041c30210719c2b75fcab30a183235b12c5dd53\", \"accessibility_unittests\": \"16ceb3e887024a9295c15086532425b802577f09\", \"angle_unittests\": \"4414dc3f42ec0a06127901dee18babad6129be4f\", \"app_list_unittests\": \"22bfb5dd17eda63ba56329c6f752480b1af759b9\", \"app_shell_unittests\": \"dae33e716e3b6049f2c15ca1a903abb1cd940efd\", \"ash_unittests\": \"04a42ebd29475b95206678820b97a566e2798883\", \"aura_unittests\": \"559780350b368c3edf833161d84faf4d109ddb56\", \"base_unittests\": \"a9e4bfba1dee3c5e008d2e494d05201cd985bbcb\", \"base_util_unittests\": \"061d7e033ff298913ce41de31ba594964fa51a96\", \"blink_common_unittests\": \"b5d64fa365a316c16b462a4d4cc0afefc5115969\", \"blink_fuzzer_unittests\": \"b77f78692052d5fa85c1d9b49b1d288fccaa742f\", \"blink_heap_unittests\": \"bac568ac45fe1f592076d04cb6e5e31c46814882\", \"blink_platform_unittests\": \"8d3679e1808a4ae91207449e69cecc590df38429\", \"blink_unittests\": \"cf0bbc2771c8ece1a4ed7928be14016104a55bb8\", \"boringssl_crypto_tests\": \"e0a906bedb95c79cd854fe9d989fba31081cd4f6\", \"boringssl_ssl_tests\": \"440a27b27369ef7f2357ffd00ada5cad55ba9f76\", \"browser_tests\": \"1e85e1004a6e2c55e53994495c1ac2a1681eb4e2\", \"capture_unittests\": \"2860419600221dda21765b2adf04391063e98fd8\", \"cast_unittests\": \"74e2255213755a8e7fd49246d95506d2bad7bb8c\", \"cc_unittests\": \"4e6c115100872baa9274ee19dc1b7ae46916155a\", \"chrome_app_unittests\": \"020d2b281c893f5848ea0d8c862a94ddf9dc4685\", \"chromedriver_unittests\": \"c5f27bfcbf14a5ee14ebdcd3b2b85611f281ee17\", \"chromeos_components_unittests\": \"b0216c4efb251dee31d0ea798b2597ce0e401f07\", \"chromeos_unittests\": \"efd496b88569a1eace3783cde4d9fb418c74be39\", \"components_browsertests\": \"e74acd142d13f63e3cc7df5d9d7b3bd36b02ed9b\", \"components_unittests\": \"40146782dab26a7cbf134eae416eaa981e837052\", \"compositor_unittests\": \"5ab1390243a176e7db36963c80e2a33146b83f02\", \"content_browsertests\": \"1ab364a21ba2b6b842a4c52d50275343fe9326b5\", \"content_unittests\": \"6f85b9283365a8a56cf35cdaabac3c7200b992d2\", \"crypto_unittests\": \"0aa8abaa8c8131db5579996cd009135ff7eb128f\", \"dbus_unittests\": \"8fc14604b9ab31afb94999979e675856d460ba64\", \"device_unittests\": \"c7466bdf0f993e37ebc516d0bd7d976e25a53195\", \"display_unittests\": \"adeb0c8f921864c9c93b8a5f1e13e9b9d3c97a96\", \"events_unittests\": \"a9412f1f36fce091c07df35ea4398b6533d31f2b\", \"exo_unittests\": \"8725bc89d651e5bad4d7e40deeff030249272396\", \"extensions_browsertests\": \"27ac2435b2fbbf29aa350e012f6ce9b95b54f74c\", \"extensions_unittests\": \"502db3d8b38db2fe4f5e0570a8c5a7a80973e3f1\", \"filesystem_service_unittests\": \"1bd445675bbce06adf0adbf239887d7bc3892179\", \"gcm_unit_tests\": \"5bbe19505c7f1c733a7b17acf6c6f2cd9043f6f5\", \"gfx_unittests\": \"fa5c3906957d483f518ff88eb0463f91785952d7\", \"gin_unittests\": \"e9f7862ee2b913b7b8939ac9b9fa9e74d467214b\", \"gl_unittests_ozone\": \"6846fc2b43ee05d630379f466a814b27f752fc06\", \"google_apis_unittests\": \"7570de93c2325f583f481e353c6ce46ebfde4179\", \"gpu_unittests\": \"f722752c7d3aa91ee660f3b77001851f21ae216b\", \"gwp_asan_unittests\": \"1ad9773ab66ab704d0afb21e4641a61d527d2f5c\", \"interactive_ui_tests\": \"7464b2e53973357d0863b41f42e351ed85faa1a2\", \"ipc_tests\": \"fe30d433d8028843b4dd5d9e7740912445931ad2\", \"jingle_unittests\": \"e595d9e618702325561158442d0a8b19a0bce02c\", \"keyboard_unittests\": \"4640caccad2b002367d7e5cf1bf533be26214733\", \"latency_unittests\": \"285b926cfc347b0a83530139b89d0ad84e9c3c23\", \"libjingle_xmpp_unittests\": \"767b2bf52bd84286dcd8bccaaf9164e0985a50f0\", \"media_blink_unittests\": \"e8b0defd01e8cf07a4bd73a5a6e5792d200a5927\", \"media_unittests\": \"1e1f2270de3179fd3084aa0c28b13f999c600ab3\", \"message_center_unittests\": \"a1ab5f7ee82e68b4d159873dfff3ba86a2133aa3\", \"midi_unittests\": \"993d032b4f4d79245bfbd359a550cfb8d96cd2f2\", \"mojo_core_unittests\": \"7f8d7ccf200a3850c8bc38cc983c59ca86319e0b\", \"mojo_unittests\": \"bc6f370ca06cec2568185d9ae02f3c63e07b32fc\", \"nacl_helper_nonsfi_unittests\": \"30d471591304ca9dd22cf6c9ba246f5bfd93b237\", \"nacl_loader_unittests\": \"766f890484184f6b155cc730cec61e3f8de8c351\", \"native_theme_unittests\": \"f3c8a7cd2c25244d3e3bd1e444878a6c99b38050\", \"net_unittests\": \"2c311591222e55d082b7ee25e98afe6d4b13672d\", \"ozone_gl_unittests\": \"ade34fb13f1c3c6c70bc8b829391c9336b90df12\", \"ozone_unittests\": \"d2a2876c027bbf9c790d6ad4c024b2ff9eea3be0\", \"ozone_x11_unittests\": \"c5374a5e9132a3ee69dc32dd99a4faca78ff04f6\", \"pdf_unittests\": \"c46a8bfe3b8edda34baa1a0f04cf7ae68c8c37d9\", \"perfetto_unittests\": \"5f3dd3d94f67ec371fb766510bb9f9f5d0451598\", \"ppapi_unittests\": \"6656bf326a93d81fd644532fcaad5423a2ed8ddb\", \"printing_unittests\": \"a0d2382d422ff1ae46b785ac21c949d462bef0bb\", \"remoting_unittests\": \"92c118f60534c2e4533acc67978ac543f5246e0f\", \"sandbox_linux_unittests\": \"8dfbfefafc8734e95ae16409e466f2abc29f72de\", \"service_manager_unittests\": \"9c1d7db6c3189ecee466c493cc35ca9de7e8eeef\", \"services_unittests\": \"0f2673a0e016825207dd43b9fed68605b76218a8\", \"shell_dialogs_unittests\": \"4d48cac2c79761e9d478cd2b787cc890646d7ef3\", \"skia_unittests\": \"629615cc4ef5341e60538f6931d325c5196bcdea\", \"snapshot_unittests\": \"5833ab4f6a1cb30e608cc8d16f67729909f82c1b\", \"sql_unittests\": \"1f5f0a65e4bfad7faaa144c7ddc5325faf76346f\", \"storage_unittests\": \"f1580613fa67e3fd347de6a4538a9750abf4b94c\", \"sync_integration_tests\": \"ab6879164628d63cceee923899e41bd3a0efadf5\", \"traffic_annotation_auditor_unittests\": \"f9775afa15e28d30793354d0490cd2d60ca37bd3\", \"ui_base_unittests\": \"7bb76b6df910600538720d9cf2459c8e8970c038\", \"ui_chromeos_unittests\": \"c8527d1507bd28ceb4d8a4e3553ffd1504c0bf9e\", \"ui_touch_selection_unittests\": \"4b36c03f87bbeabf8ee842b4515ed517834a1b4d\", \"unit_tests\": \"5be2fd9698814e9b112db3c469dfc2c6a551724c\", \"url_unittests\": \"fd1ae726c16cb65334df7cd63051db6c5cb3a1dc\", \"usage_time_limit_unittests\": \"4b1e3f2366b51909ffdbe94fd29414fcf38e8db7\", \"views_unittests\": \"22ffbb66d6afdf77739522b656b337a2f5b4e694\", \"viz_unittests\": \"3a3ee9cdec298acc6945aa0539d0005c9e079675\", \"wayland_client_perftests\": \"dd4b68f7277a6d909ee2452f739127b3e745e5dd\", \"wm_unittests\": \"a514a29dff81b304e79ce4cce4904008ccfc36bd\", \"wtf_unittests\": \"fb4f8b28f46f313f3e94235791628909aac2da69\", \"zlib_unittests\": \"ee28b915f0347a8bd817962d6716d24fff25721b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_ddf530b99db2c48999a16b04f27f886d0f06df616543b36733eb8d0558bd23f5_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-61-durd\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603776637001542",
"status": "COMPLETED",
"status_changed_ts": "1603779987301120",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42300",
"builder:linux-chromeos-rel",
"buildset:commit/git/d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0876ff7146bc25f5ef73f75fdc9e23ff1d1bd79",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030742100465694688",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865312038462077088/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4f815ac619690510",
"user_agent:luci-scheduler"
],
"updated_ts": "1603779987320190",
"url": "https://ci.chromium.org/b/8865312038462077088",
"utcnow_ts": "1603779987762937"
}
}
[06:26:27.782] Invocation finished in 56m4.877209335s with status SUCCEEDED