[12:55:30.446] New invocation is queued and will start shortly
[12:55:31.594] Starting the invocation (attempt 1)
[12:55:31.631] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:55:31.631] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:55:31.631] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020657832324259232",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"18de4a17440d1535254150a82bd0eaa4598e506a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020657832324259232",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/18de4a17440d1535254150a82bd0eaa4598e506a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18de4a17440d1535254150a82bd0eaa4598e506a",
"gitiles_ref:refs/heads/master"
]
}
[12:55:32.842] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613393731790492",
"id": "8855227770253194608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18de4a17440d1535254150a82bd0eaa4598e506a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613393732636730",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45427",
"builder:linux-chromeos-rel",
"buildset:commit/git/18de4a17440d1535254150a82bd0eaa4598e506a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18de4a17440d1535254150a82bd0eaa4598e506a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020657832324259232",
"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/8855227770253194608/+/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": "1613393732636856",
"url": "https://ci.chromium.org/b/8855227770253194608",
"utcnow_ts": "1613393732828140"
}
}
[12:55:32.842] Task URL: https://ci.chromium.org/b/8855227770253194608
[12:55:32.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:2:0) after 1m0s
[12:55:37.021] Received PubSub notification, asking Buildbucket for the build status
[12:55:37.102] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:32.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:2:0)
[12:56:32.870] Timer tick, asking Buildbucket for the build status
[12:56:32.949] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:32.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:4:0) after 1m0s
[12:57:32.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:4:0)
[12:57:32.941] Timer tick, asking Buildbucket for the build status
[12:57:33.203] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:33.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:5:0) after 1m0s
[12:58:33.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:5:0)
[12:58:33.209] Timer tick, asking Buildbucket for the build status
[12:58:33.288] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:33.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:6:0) after 1m0s
[12:59:33.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:6:0)
[12:59:33.317] Timer tick, asking Buildbucket for the build status
[12:59:33.520] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:33.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:7:0) after 1m0s
[13:00:33.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:7:0)
[13:00:33.526] Timer tick, asking Buildbucket for the build status
[13:00:34.985] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:34.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:8:0) after 1m0s
[13:01:35.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:8:0)
[13:01:35.259] Timer tick, asking Buildbucket for the build status
[13:01:35.363] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:35.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:9:0) after 1m0s
[13:02:35.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:9:0)
[13:02:35.424] Timer tick, asking Buildbucket for the build status
[13:02:35.847] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:35.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:10:0) after 1m0s
[13:03:36.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:10:0)
[13:03:36.099] Timer tick, asking Buildbucket for the build status
[13:03:36.198] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:36.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:11:0) after 1m0s
[13:04:36.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:11:0)
[13:04:36.314] Timer tick, asking Buildbucket for the build status
[13:04:36.509] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:36.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:12:0) after 1m0s
[13:05:36.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:12:0)
[13:05:36.569] Timer tick, asking Buildbucket for the build status
[13:05:36.700] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:36.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:13:0) after 1m0s
[13:06:36.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:13:0)
[13:06:36.789] Timer tick, asking Buildbucket for the build status
[13:06:37.035] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:37.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:14:0) after 1m0s
[13:07:37.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:14:0)
[13:07:37.170] Timer tick, asking Buildbucket for the build status
[13:07:37.418] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:37.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:15:0) after 1m0s
[13:08:37.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:15:0)
[13:08:37.496] Timer tick, asking Buildbucket for the build status
[13:08:37.575] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:37.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:16:0) after 1m0s
[13:09:37.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:16:0)
[13:09:37.635] Timer tick, asking Buildbucket for the build status
[13:09:37.704] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:37.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:17:0) after 1m0s
[13:10:37.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:17:0)
[13:10:37.770] Timer tick, asking Buildbucket for the build status
[13:10:37.915] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:37.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:18:0) after 1m0s
[13:11:38.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:18:0)
[13:11:38.041] Timer tick, asking Buildbucket for the build status
[13:11:38.123] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:38.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:19:0) after 1m0s
[13:12:38.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:19:0)
[13:12:38.146] Timer tick, asking Buildbucket for the build status
[13:12:38.307] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:38.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:20:0) after 1m0s
[13:13:38.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:20:0)
[13:13:38.409] Timer tick, asking Buildbucket for the build status
[13:13:38.520] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:38.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:21:0) after 1m0s
[13:14:38.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:21:0)
[13:14:38.575] Timer tick, asking Buildbucket for the build status
[13:14:38.684] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:38.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:22:0) after 1m0s
[13:15:38.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:22:0)
[13:15:38.731] Timer tick, asking Buildbucket for the build status
[13:15:38.884] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:38.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:23:0) after 1m0s
[13:16:38.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:23:0)
[13:16:38.957] Timer tick, asking Buildbucket for the build status
[13:16:39.088] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:39.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:24:0) after 1m0s
[13:17:39.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:24:0)
[13:17:39.183] Timer tick, asking Buildbucket for the build status
[13:17:39.288] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:39.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:25:0) after 1m0s
[13:18:39.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:25:0)
[13:18:39.432] Timer tick, asking Buildbucket for the build status
[13:18:39.516] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:39.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:26:0) after 1m0s
[13:19:39.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:26:0)
[13:19:39.604] Timer tick, asking Buildbucket for the build status
[13:19:39.796] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:39.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:27:0) after 1m0s
[13:20:39.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:27:0)
[13:20:39.846] Timer tick, asking Buildbucket for the build status
[13:20:39.998] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:39.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:28:0) after 1m0s
[13:21:40.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:28:0)
[13:21:40.001] Timer tick, asking Buildbucket for the build status
[13:21:40.209] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:40.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:29:0) after 1m0s
[13:22:40.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:29:0)
[13:22:40.222] Timer tick, asking Buildbucket for the build status
[13:22:40.465] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:40.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:30:0) after 1m0s
[13:23:40.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:30:0)
[13:23:40.486] Timer tick, asking Buildbucket for the build status
[13:23:40.570] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:40.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:31:0) after 1m0s
[13:24:40.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:31:0)
[13:24:40.632] Timer tick, asking Buildbucket for the build status
[13:24:40.707] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:40.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:32:0) after 1m0s
[13:25:40.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:32:0)
[13:25:40.787] Timer tick, asking Buildbucket for the build status
[13:25:40.908] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:40.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:33:0) after 1m0s
[13:26:41.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:33:0)
[13:26:41.000] Timer tick, asking Buildbucket for the build status
[13:26:41.489] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:41.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:34:0) after 1m0s
[13:27:41.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:34:0)
[13:27:41.511] Timer tick, asking Buildbucket for the build status
[13:27:41.590] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:41.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:35:0) after 1m0s
[13:28:41.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:35:0)
[13:28:41.709] Timer tick, asking Buildbucket for the build status
[13:28:41.814] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:41.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:36:0) after 1m0s
[13:29:41.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:36:0)
[13:29:41.893] Timer tick, asking Buildbucket for the build status
[13:29:41.982] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:41.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:37:0) after 1m0s
[13:30:42.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:37:0)
[13:30:42.071] Timer tick, asking Buildbucket for the build status
[13:30:42.171] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:42.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:38:0) after 1m0s
[13:31:42.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:38:0)
[13:31:42.354] Timer tick, asking Buildbucket for the build status
[13:31:42.436] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:42.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:39:0) after 1m0s
[13:32:42.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:39:0)
[13:32:42.555] Timer tick, asking Buildbucket for the build status
[13:32:42.796] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:42.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:40:0) after 1m0s
[13:33:42.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:40:0)
[13:33:42.865] Timer tick, asking Buildbucket for the build status
[13:33:42.957] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:42.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:41:0) after 1m0s
[13:34:42.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:41:0)
[13:34:42.994] Timer tick, asking Buildbucket for the build status
[13:34:43.111] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:43.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:42:0) after 1m0s
[13:35:43.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:42:0)
[13:35:43.304] Timer tick, asking Buildbucket for the build status
[13:35:43.726] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:43.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:43:0) after 1m0s
[13:36:43.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:43:0)
[13:36:43.812] Timer tick, asking Buildbucket for the build status
[13:36:43.902] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:43.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:44:0) after 1m0s
[13:37:43.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:44:0)
[13:37:43.926] Timer tick, asking Buildbucket for the build status
[13:37:44.002] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:44.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:45:0) after 1m0s
[13:38:44.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:45:0)
[13:38:44.082] Timer tick, asking Buildbucket for the build status
[13:38:44.308] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:44.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:46:0) after 1m0s
[13:39:44.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:46:0)
[13:39:44.476] Timer tick, asking Buildbucket for the build status
[13:39:44.604] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:44.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:47:0) after 1m0s
[13:40:44.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:47:0)
[13:40:44.679] Timer tick, asking Buildbucket for the build status
[13:40:44.787] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:44.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:48:0) after 1m0s
[13:41:44.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:48:0)
[13:41:44.863] Timer tick, asking Buildbucket for the build status
[13:41:45.032] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:45.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:49:0) after 1m0s
[13:42:45.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:49:0)
[13:42:45.101] Timer tick, asking Buildbucket for the build status
[13:42:45.577] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:45.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:50:0) after 1m0s
[13:43:45.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:50:0)
[13:43:45.631] Timer tick, asking Buildbucket for the build status
[13:43:46.069] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:46.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:51:0) after 1m0s
[13:44:46.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:51:0)
[13:44:46.092] Timer tick, asking Buildbucket for the build status
[13:44:46.216] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:46.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:52:0) after 1m0s
[13:45:46.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:52:0)
[13:45:46.312] Timer tick, asking Buildbucket for the build status
[13:45:46.767] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:46.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:53:0) after 1m0s
[13:46:46.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:53:0)
[13:46:46.828] Timer tick, asking Buildbucket for the build status
[13:46:46.912] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:46.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:54:0) after 1m0s
[13:47:46.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:54:0)
[13:47:46.991] Timer tick, asking Buildbucket for the build status
[13:47:47.083] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:47.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:55:0) after 1m0s
[13:48:47.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:55:0)
[13:48:47.128] Timer tick, asking Buildbucket for the build status
[13:48:47.209] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:47.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:56:0) after 1m0s
[13:49:47.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:56:0)
[13:49:47.186] Timer tick, asking Buildbucket for the build status
[13:49:47.281] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:47.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:57:0) after 1m0s
[13:50:47.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:57:0)
[13:50:47.305] Timer tick, asking Buildbucket for the build status
[13:50:47.412] Build 8855227770253194608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:47.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020657832324259232:58:0) after 1m0s
[13:51:00.515] Received PubSub notification, asking Buildbucket for the build status
[13:51:00.796] Build 8855227770253194608: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:51:00.796] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613397059276248",
"created_by": "project:chromium",
"created_ts": "1613393731790492",
"id": "8855227770253194608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18de4a17440d1535254150a82bd0eaa4598e506a\"}}",
"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\": \"18de4a17440d1535254150a82bd0eaa4598e506a\", \"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-79-xanh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45427, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"18de4a17440d1535254150a82bd0eaa4598e506a\", \"got_revision_cp\": \"refs/heads/master@{#854020}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"a24f3d035f7d9acee551d5547f4fb16838cf98d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33258}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18de4a17440d1535254150a82bd0eaa4598e506a\", \"swarm_hashes_refs/heads/master(at){#854020}_without_patch\": {\"absl_hardening_tests\": \"da9b2fb411fe3bc3257ea956d5510b798325a542\", \"accessibility_unittests\": \"5acddeeea900df3a6818eac688305afbed0b3710\", \"angle_unittests\": \"4209db2d5c615ec922dcd8cda0eeb9b6eb20f892\", \"app_list_unittests\": \"dd95707f8b912560608e7b1422ce4df19d1ab679\", \"app_shell_unittests\": \"e39f4ce0397f844f1038d01fe7c9bbd20d8cc34c\", \"ash_unittests\": \"71f1464a05e2e43beda22c54a0ea44acd43100b4\", \"aura_unittests\": \"7c5d2dc2321f7407f4e776ed49c524a49ebd6b3a\", \"base_unittests\": \"54fd98850e8f0ef8453c6b1f73d1ab9980b46225\", \"base_util_unittests\": \"9f2625b4f21434dbfe800ac69a9ad6daf7c695d0\", \"blink_common_unittests\": \"b6119cc140e3b17fa0358223bfa03df40a89a855\", \"blink_fuzzer_unittests\": \"31210ec9038260e77ac5319db4786d23fb5fb3f0\", \"blink_heap_unittests\": \"004b19e18e70ab328ed11cebdc34b532ad771cd6\", \"blink_platform_unittests\": \"356768a32a228e410c5b54b129db6777f7e23658\", \"blink_unittests\": \"969697e7c6ec88d9b501dfb554b3980d9f30d45b\", \"boringssl_crypto_tests\": \"24957053378da4dc9f3486ad96558713bb0ce20f\", \"boringssl_ssl_tests\": \"870c831930e434835010dd5708208fb1b8e2d8d9\", \"browser_tests\": \"c44f80037cef1064af3d9cf1b56cd75a8bcbe748\", \"capture_unittests\": \"027ef4ada37529e312455738f6495e83c3211c7a\", \"cast_unittests\": \"616af3bdcfd64f549690ba718ba4d39891753b2c\", \"cc_unittests\": \"6106d8fad80beb857449848c0b5434307d392c72\", \"chrome_app_unittests\": \"e7455417708ef3075e94d89b4bb25c756726683c\", \"chromedriver_unittests\": \"3db9da6e6067da692252a5643236599280edf962\", \"chromeos_components_unittests\": \"0125724b72cfd1d0201e8a39bca0d7c10aa9de39\", \"chromeos_unittests\": \"a1c2fbd0dde3b7d0d0e1455b3cec775828b16d3b\", \"components_browsertests\": \"8663b2e6f7a3d731cbef1b9c53d34f0f1041c90f\", \"components_unittests\": \"519aba017805933c410c7e90dbc23cf4ddbc4c22\", \"compositor_unittests\": \"28ae6ab181aa94c30ae58b0988e712a366d4041b\", \"content_browsertests\": \"cc949f51b1164bd32dbe891c4c70be7d73f38727\", \"content_unittests\": \"6c69f2bac6f8de012c1331d27a6ef2c3e9974b3c\", \"crashpad_tests\": \"3917eb46eeef7f7c2a2eb77efb4cce4efdb5bcd3\", \"crypto_unittests\": \"03bc7fc0db9920f9780d6b53ba040a0045a6980f\", \"dbus_unittests\": \"a87bff0dde5d7e5a14bf28eb07c5d3950d70435d\", \"device_unittests\": \"3c351b3a9fd530dfbf985cf88a32fa48278b0128\", \"display_unittests\": \"ff4db0e26f7a3517bf8bf163a4e8be54d5eb6fbb\", \"events_unittests\": \"e1be3ab9d4305d204debb0d00dfe4be20ba554a4\", \"exo_unittests\": \"c830632f0722b0446ef604de6391b1f77fc4a08e\", \"extensions_browsertests\": \"527c6930ab12061742988bfd1ada69ae812840e7\", \"extensions_unittests\": \"2bfa3ba87aeed69626e77c2a4934a92162ce6615\", \"filesystem_service_unittests\": \"c73fd39a08e34b0acbb456d83436a322d39c8762\", \"gcm_unit_tests\": \"b516e7d0be2940180a6cb3f417d3ae233f52b774\", \"gfx_unittests\": \"9b195e3a7973d94d9236644892db7f66011166ac\", \"gin_unittests\": \"4e4b3ce24afbc86e2bf68a18c6a755fb3db6471c\", \"gl_unittests_ozone\": \"777bd71e169a7519d56dd79fd98fe21bf447e9eb\", \"google_apis_unittests\": \"ba1cfe9e9a5f575dd226a4248ac53310344db190\", \"gpu_unittests\": \"4e8249b902944318fc597e856638fc0a6cb8da03\", \"gwp_asan_unittests\": \"b092f4b004cdc9353637c31378ce7feb5cd01fd2\", \"interactive_ui_tests\": \"16a15d1a59e609bd4adcd767f033431b006d8316\", \"ipc_tests\": \"4f7eea6c6e0fc8df8b16120803ac05655b48230f\", \"jingle_unittests\": \"49e4328a44ff76e6870753361e17f9c345c3e45b\", \"keyboard_unittests\": \"64919ab71028ea1309bd45a3a9c2dce170495aa0\", \"latency_unittests\": \"86afcbffbceefd4e313216812b3ddd12481754da\", \"libjingle_xmpp_unittests\": \"93bc1576d404a27112e6d67eb5b6fc115ee7799c\", \"liburlpattern_unittests\": \"607279cdf42e8239103863d029609e168e8d2d52\", \"media_blink_unittests\": \"f9b657d66f5311e2efd808e128b7c248dcc939ae\", \"media_unittests\": \"8adfc7ef9038e9d8088618a52619652683f27348\", \"message_center_unittests\": \"fe7df255c172e261a95a2bccf231ffdf6dd8ea6f\", \"midi_unittests\": \"9da667fd40f04d5bdfc9604f856ed5184ded1ed2\", \"mojo_core_unittests\": \"fdcfc6d82b7fe14643ed2fb8b0d094a8eba4fba8\", \"mojo_unittests\": \"5cdf9b3ef9eb5ae5513f9cb22294de2cd940ccf3\", \"nacl_helper_nonsfi_unittests\": \"5394d16e22e12df85a32d9090ab89ff429393b3d\", \"nacl_loader_unittests\": \"7cc1b40ae3bd81d69f32f5b941cb2dd61621c00f\", \"native_theme_unittests\": \"3a343a7f512f0448178ca877d817cb65638b5567\", \"net_unittests\": \"e63197844c203a46635a4c798d35e6d705ae9e85\", \"ozone_gl_unittests\": \"7beba6c75f79f680488e1b2c6d22401ae96fa49b\", \"ozone_unittests\": \"475f685ba9bd61a79315f9b20b06f4a4170f7ff6\", \"ozone_x11_unittests\": \"cdaa5f01189a546036215e3e550fd0eb0e18a609\", \"pdf_unittests\": \"ae5f8a3a21491d906021d689bea4b26f6aa5a800\", \"perfetto_unittests\": \"cf5c50e6d17ced0aa244bf394b6ac4283cfc47ef\", \"ppapi_unittests\": \"66871050a1d77442f1b2b9d217cc02a54ca84d3e\", \"printing_unittests\": \"bbaab5cfde661f744cfb74d1d3d2d72423959e57\", \"remoting_unittests\": \"2f5e9403f1588660f1268e496d40c63e0e97bd58\", \"sandbox_linux_unittests\": \"c24f3b7abeaa3d4698a3d872614507b108aadf1b\", \"service_manager_unittests\": \"ade41a12472ed3d2e2a46faad6084d8ef15c0e86\", \"services_unittests\": \"e9d846a73c9773d56e6bae04ea1f423718d95041\", \"shell_dialogs_unittests\": \"8e2fe99a1dd83bb19eb0909738d849c9fde84901\", \"shell_encryption_unittests\": \"a5570fe4e4acc822b469c8fa776f09db764253ed\", \"skia_unittests\": \"870b4a00905eeda3b2e5ee96e333ac48bc6cd05c\", \"snapshot_unittests\": \"742c69d2c327f83a0fe54e75ddc3309fe3616788\", \"sql_unittests\": \"aca7fd358678b4c584ce079df8f89f3ec5867777\", \"storage_unittests\": \"5660f12609457ca0a92a5391fc62951fe582ee1d\", \"sync_integration_tests\": \"f868288ab64cfc9f162f6765fd7d972bd8c58b4f\", \"traffic_annotation_auditor_unittests\": \"979ed14280fb852b0fb179700c3405fd6d9e8361\", \"ui_base_unittests\": \"e148b6453314d45908a5f3c8931a21bbfed112fc\", \"ui_chromeos_unittests\": \"f575b1e7256831f328d74922f1824a52bc781098\", \"ui_touch_selection_unittests\": \"7388367a99e8738cf0dbd656989c979e357f2a94\", \"unit_tests\": \"05a1b08163d9c4e418547b3a4a8711d17bce1e90\", \"url_unittests\": \"6973d9784fe53ae9cd3142d4bd10d612d7ce90d7\", \"usage_time_limit_unittests\": \"b4b5061ef1934b03504a2426b10735daa4c5126b\", \"views_unittests\": \"f362d47378cf43979e734a1add61eeb5f3cd39c3\", \"viz_unittests\": \"8ff499d265014f4f108e3508ab65ce251e186c55\", \"wayland_client_perftests\": \"31b26035b5c89e59047f2b653bea7175c101bc19\", \"wm_unittests\": \"e70b3465bf9014a40c27a0f00079a70345284bdb\", \"wtf_unittests\": \"2ee49e3af0ce6527fe5035b222683c5bfe0f3402\", \"zlib_unittests\": \"a8f4485d114f0347a162106d247151bcc274cba1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_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-79-xanh\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5696-2a606bc\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613393735895411",
"status": "COMPLETED",
"status_changed_ts": "1613397059699760",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45427",
"builder:linux-chromeos-rel",
"buildset:commit/git/18de4a17440d1535254150a82bd0eaa4598e506a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18de4a17440d1535254150a82bd0eaa4598e506a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020657832324259232",
"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/8855227770253194608/+/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:51be942d2014bd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613397059707225",
"url": "https://ci.chromium.org/b/8855227770253194608",
"utcnow_ts": "1613397060775916"
}
}
[13:51:00.796] Invocation finished in 55m30.365650141s with status SUCCEEDED