[23:36:18.238] New invocation is queued and will start shortly
[23:36:19.296] Starting the invocation (attempt 1)
[23:36:19.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:36:19.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:36:19.337] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031217361963122048",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6818369fc298255ef7498d544e35d0519b28902b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9031217361963122048",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/6818369fc298255ef7498d544e35d0519b28902b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6818369fc298255ef7498d544e35d0519b28902b",
"gitiles_ref:refs/heads/master"
]
}
[23:36:19.863] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603323379424355",
"id": "8865787300054919344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6818369fc298255ef7498d544e35d0519b28902b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603323379748288",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42158",
"builder:linux-chromeos-rel",
"buildset:commit/git/6818369fc298255ef7498d544e35d0519b28902b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6818369fc298255ef7498d544e35d0519b28902b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031217361963122048",
"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/8865787300054919344/+/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": "1603323379748397",
"url": "https://ci.chromium.org/b/8865787300054919344",
"utcnow_ts": "1603323379855904"
}
}
[23:36:19.863] Task URL: https://ci.chromium.org/b/8865787300054919344
[23:36:19.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:2:0) after 1m0s
[23:37:19.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:2:0)
[23:37:19.908] Timer tick, asking Buildbucket for the build status
[23:37:20.113] Build 8865787300054919344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:20.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:3:0) after 1m0s
[23:37:32.362] Received PubSub notification, asking Buildbucket for the build status
[23:37:32.440] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:20.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:3:0)
[23:38:20.167] Timer tick, asking Buildbucket for the build status
[23:38:20.300] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:20.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:5:0) after 1m0s
[23:39:20.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:5:0)
[23:39:20.355] Timer tick, asking Buildbucket for the build status
[23:39:20.462] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:20.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:6:0) after 1m0s
[23:40:20.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:6:0)
[23:40:20.550] Timer tick, asking Buildbucket for the build status
[23:40:20.631] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:20.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:7:0) after 1m0s
[23:41:20.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:7:0)
[23:41:20.837] Timer tick, asking Buildbucket for the build status
[23:41:20.970] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:20.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:8:0) after 1m0s
[23:42:20.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:8:0)
[23:42:20.992] Timer tick, asking Buildbucket for the build status
[23:42:21.331] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:9:0) after 1m0s
[23:43:21.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:9:0)
[23:43:21.354] Timer tick, asking Buildbucket for the build status
[23:43:22.020] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:22.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:10:0) after 1m0s
[23:44:22.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:10:0)
[23:44:22.128] Timer tick, asking Buildbucket for the build status
[23:44:22.196] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:22.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:11:0) after 1m0s
[23:45:22.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:11:0)
[23:45:22.249] Timer tick, asking Buildbucket for the build status
[23:45:22.618] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:22.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:12:0) after 1m0s
[23:46:22.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:12:0)
[23:46:22.673] Timer tick, asking Buildbucket for the build status
[23:46:22.796] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:22.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:13:0) after 1m0s
[23:47:22.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:13:0)
[23:47:22.797] Timer tick, asking Buildbucket for the build status
[23:47:22.865] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:22.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:14:0) after 1m0s
[23:48:22.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:14:0)
[23:48:22.849] Timer tick, asking Buildbucket for the build status
[23:48:22.941] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:22.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:15:0) after 1m0s
[23:49:22.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:15:0)
[23:49:22.951] Timer tick, asking Buildbucket for the build status
[23:49:23.026] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:23.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:16:0) after 1m0s
[23:50:23.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:16:0)
[23:50:23.100] Timer tick, asking Buildbucket for the build status
[23:50:23.237] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:23.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:17:0) after 1m0s
[23:51:23.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:17:0)
[23:51:23.313] Timer tick, asking Buildbucket for the build status
[23:51:23.422] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:23.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:18:0) after 1m0s
[23:52:23.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:18:0)
[23:52:23.442] Timer tick, asking Buildbucket for the build status
[23:52:23.506] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:23.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:19:0) after 1m0s
[23:53:23.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:19:0)
[23:53:23.525] Timer tick, asking Buildbucket for the build status
[23:53:23.647] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:23.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:20:0) after 1m0s
[23:54:23.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:20:0)
[23:54:23.669] Timer tick, asking Buildbucket for the build status
[23:54:23.755] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:23.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:21:0) after 1m0s
[23:55:23.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:21:0)
[23:55:23.834] Timer tick, asking Buildbucket for the build status
[23:55:23.917] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:23.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:22:0) after 1m0s
[23:56:23.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:22:0)
[23:56:23.950] Timer tick, asking Buildbucket for the build status
[23:56:24.044] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:24.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:23:0) after 1m0s
[23:57:24.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:23:0)
[23:57:24.076] Timer tick, asking Buildbucket for the build status
[23:57:24.138] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:24.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:24:0) after 1m0s
[23:58:24.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:24:0)
[23:58:24.127] Timer tick, asking Buildbucket for the build status
[23:58:24.178] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:24.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:25:0) after 1m0s
[23:59:24.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:25:0)
[23:59:24.205] Timer tick, asking Buildbucket for the build status
[23:59:24.272] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:24.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:26:0) after 1m0s
[00:00:24.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:26:0)
[00:00:24.351] Timer tick, asking Buildbucket for the build status
[00:00:24.412] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:24.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:27:0) after 1m0s
[00:01:24.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:27:0)
[00:01:24.479] Timer tick, asking Buildbucket for the build status
[00:01:24.632] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:24.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:28:0) after 1m0s
[00:02:24.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:28:0)
[00:02:24.667] Timer tick, asking Buildbucket for the build status
[00:02:24.990] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:24.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:29:0) after 1m0s
[00:03:25.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:29:0)
[00:03:25.084] Timer tick, asking Buildbucket for the build status
[00:03:25.147] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:25.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:30:0) after 1m0s
[00:04:25.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:30:0)
[00:04:25.173] Timer tick, asking Buildbucket for the build status
[00:04:25.732] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:25.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:31:0) after 1m0s
[00:05:27.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:31:0)
[00:05:27.215] Timer tick, asking Buildbucket for the build status
[00:05:27.295] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:27.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:32:0) after 1m0s
[00:06:27.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:32:0)
[00:06:27.345] Timer tick, asking Buildbucket for the build status
[00:06:27.607] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:27.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:33:0) after 1m0s
[00:07:27.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:33:0)
[00:07:27.639] Timer tick, asking Buildbucket for the build status
[00:07:27.946] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:27.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:34:0) after 1m0s
[00:08:28.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:34:0)
[00:08:28.013] Timer tick, asking Buildbucket for the build status
[00:08:28.083] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:28.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:35:0) after 1m0s
[00:09:28.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:35:0)
[00:09:28.111] Timer tick, asking Buildbucket for the build status
[00:09:28.410] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:28.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:36:0) after 1m0s
[00:10:28.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:36:0)
[00:10:28.385] Timer tick, asking Buildbucket for the build status
[00:10:28.583] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:28.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:37:0) after 1m0s
[00:11:28.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:37:0)
[00:11:28.667] Timer tick, asking Buildbucket for the build status
[00:11:28.762] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:28.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:38:0) after 1m0s
[00:12:28.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:38:0)
[00:12:28.787] Timer tick, asking Buildbucket for the build status
[00:12:28.866] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:28.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:39:0) after 1m0s
[00:13:28.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:39:0)
[00:13:28.890] Timer tick, asking Buildbucket for the build status
[00:13:29.419] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:29.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:40:0) after 1m0s
[00:14:29.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:40:0)
[00:14:29.456] Timer tick, asking Buildbucket for the build status
[00:14:29.562] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:29.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:41:0) after 1m0s
[00:15:29.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:41:0)
[00:15:29.585] Timer tick, asking Buildbucket for the build status
[00:15:29.725] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:29.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:42:0) after 1m0s
[00:16:29.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:42:0)
[00:16:29.758] Timer tick, asking Buildbucket for the build status
[00:16:29.883] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:29.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:43:0) after 1m0s
[00:17:29.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:43:0)
[00:17:29.959] Timer tick, asking Buildbucket for the build status
[00:17:30.199] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:30.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:44:0) after 1m0s
[00:18:30.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:44:0)
[00:18:30.369] Timer tick, asking Buildbucket for the build status
[00:18:30.502] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:30.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:45:0) after 1m0s
[00:19:30.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:45:0)
[00:19:30.578] Timer tick, asking Buildbucket for the build status
[00:19:30.697] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:30.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:46:0) after 1m0s
[00:20:30.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:46:0)
[00:20:30.761] Timer tick, asking Buildbucket for the build status
[00:20:30.990] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:30.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:47:0) after 1m0s
[00:21:30.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:47:0)
[00:21:30.989] Timer tick, asking Buildbucket for the build status
[00:21:31.385] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:31.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:48:0) after 1m0s
[00:22:31.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:48:0)
[00:22:31.486] Timer tick, asking Buildbucket for the build status
[00:22:31.636] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:31.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:49:0) after 1m0s
[00:23:31.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:49:0)
[00:23:31.730] Timer tick, asking Buildbucket for the build status
[00:23:31.894] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:31.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:50:0) after 1m0s
[00:24:31.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:50:0)
[00:24:31.925] Timer tick, asking Buildbucket for the build status
[00:24:32.172] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:32.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:51:0) after 1m0s
[00:25:32.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:51:0)
[00:25:32.260] Timer tick, asking Buildbucket for the build status
[00:25:32.713] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:32.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:52:0) after 1m0s
[00:26:32.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:52:0)
[00:26:32.792] Timer tick, asking Buildbucket for the build status
[00:26:33.009] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:33.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:53:0) after 1m0s
[00:27:33.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:53:0)
[00:27:33.045] Timer tick, asking Buildbucket for the build status
[00:27:33.237] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:33.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:54:0) after 1m0s
[00:28:33.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:54:0)
[00:28:33.285] Timer tick, asking Buildbucket for the build status
[00:28:33.528] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:33.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:55:0) after 1m0s
[00:29:33.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:55:0)
[00:29:33.549] Timer tick, asking Buildbucket for the build status
[00:29:33.669] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:33.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:56:0) after 1m0s
[00:30:33.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:56:0)
[00:30:33.719] Timer tick, asking Buildbucket for the build status
[00:30:34.064] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:34.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:57:0) after 1m0s
[00:31:34.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:57:0)
[00:31:34.051] Timer tick, asking Buildbucket for the build status
[00:31:34.209] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:34.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:58:0) after 1m0s
[00:32:34.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:58:0)
[00:32:34.262] Timer tick, asking Buildbucket for the build status
[00:32:34.408] Build 8865787300054919344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:34.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031217361963122048:59:0) after 1m0s
[00:33:30.276] Received PubSub notification, asking Buildbucket for the build status
[00:33:30.591] Build 8865787300054919344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:33:30.591] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603326807785491",
"created_by": "project:chromium",
"created_ts": "1603323379424355",
"id": "8865787300054919344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6818369fc298255ef7498d544e35d0519b28902b\"}}",
"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\": \"6818369fc298255ef7498d544e35d0519b28902b\", \"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-27-4vcg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42158, \"got_angle_revision\": \"6029e464cf9306f110fb40d10467170e87b74a50\", \"got_dawn_revision\": \"45b6de9149c16885603fab408c9a243c0a78c2b5\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"6818369fc298255ef7498d544e35d0519b28902b\", \"got_revision_cp\": \"refs/heads/master@{#819567}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6818369fc298255ef7498d544e35d0519b28902b\", \"swarm_hashes_refs/heads/master(at){#819567}_without_patch\": {\"absl_hardening_tests\": \"f12d0204151d72ce46da2dfc72a9193d1d9e15ca\", \"accessibility_unittests\": \"4448bdfa5556dd8e83331a2aea2cbbfb9244ce19\", \"app_list_unittests\": \"bc121a97dad3810fa7500f656fa2ba6de8277c49\", \"app_shell_unittests\": \"9c2669cdd5387e6b87e8ef1b59dbc7ddbcbc4a25\", \"ash_unittests\": \"9bcfc77aa1eacba84d38147e31dd575c2b0a030e\", \"aura_unittests\": \"6806ea4b777970dd099f269e9ff3bd74d85975e3\", \"base_unittests\": \"64ffa4cbc0428a3704463b6cc3f06cf9a31e006b\", \"base_util_unittests\": \"271e47643f5dec9389701e9c95c6c0b751016086\", \"blink_common_unittests\": \"0b8ce39fb56faab100b762d38a9b6990fe1da7dd\", \"blink_fuzzer_unittests\": \"7167183a8e5476a4ad6ed1e4e80c86297208a54a\", \"blink_heap_unittests\": \"424b743c4583b4f36ad2975abc58ff6784c822ab\", \"blink_platform_unittests\": \"adc64d4c04a6e70f4113e623706e06275d2b3988\", \"blink_unittests\": \"f5c935e40055db6bb4d0e7f9a15f7191b6f45347\", \"boringssl_crypto_tests\": \"1d26953a6be4bcf5a478d4da301b0afbbda65748\", \"boringssl_ssl_tests\": \"c10a072571836e624b8b95187bcd4b63ed48e079\", \"browser_tests\": \"f4b1db35e56f9a8e0525a59439608b72270a86da\", \"capture_unittests\": \"929612ec417111922da939bbf7582083e5cf1956\", \"cast_unittests\": \"8f3cccad1232d235a8a60aad7bf5a884c416388e\", \"cc_unittests\": \"0eba1b1d4a020d9ff26d96954a84abceacb1f035\", \"chrome_app_unittests\": \"d837720ee72d6a6f66724d62c4a71acd6f3ae5d3\", \"chromedriver_unittests\": \"b976ef6664f8635a99d6c7f70f3e63612518d001\", \"chromeos_components_unittests\": \"a7864af23c7df46aa6cc38c297945d653c2e4898\", \"chromeos_unittests\": \"d5fd769fe2d7b6bcee4ee313143c13f484064d2b\", \"components_browsertests\": \"189eb6a00114fa0d834cb704f8a18e1648de2efa\", \"components_unittests\": \"7d682b695d49caf85d1c028155a1b4c09958765c\", \"compositor_unittests\": \"e7c335403497e5f89d6f5bda3aa0aad93a418dd5\", \"content_browsertests\": \"e390d24b6fe9769daa3206690ba4f203cadb08a1\", \"content_unittests\": \"d73752b6cd1de72bc1fdbb1cefc227bd06b802b2\", \"crypto_unittests\": \"d1a538754ab1dbb6c6e268074cc28b40861f9364\", \"dbus_unittests\": \"9c36674b43faead5b8796d2897b2a2dcfb21d36e\", \"device_unittests\": \"2c80333e7c2216a66e3d84abb9d68196ef02870d\", \"display_unittests\": \"6e804a5bda94e4d1e09725805f49d06ed61b2120\", \"events_unittests\": \"a663914a6f70077a6242eb745a86e577ec0315b0\", \"exo_unittests\": \"cc637e06cb9d10855dec8fbb79b450d04050aea1\", \"extensions_browsertests\": \"17e27473152a6bf2b36b964ad1b51d1c4a1b9a23\", \"extensions_unittests\": \"ccf13823995dd2a099406842da00b9a9a09a2509\", \"filesystem_service_unittests\": \"6f5d46cf05a87a331c7e488432376b3a1fc65f94\", \"gcm_unit_tests\": \"4c7dc2c0b972f1955c991cbbcc40712c68f76ee3\", \"gfx_unittests\": \"371c9917d15ba1173828c22af1745623a7ddf15d\", \"gin_unittests\": \"ddea595161e6e2f150318e40e7a99906beae9a75\", \"gl_unittests_ozone\": \"298336b33cb98d7c8019c886c1aebd1d2367ed9a\", \"google_apis_unittests\": \"e43e42ac59ff25f535cc5d7600b8b216bccb3d22\", \"gpu_unittests\": \"e44303a4ece93203a4ef1483b161a9d77fe5d756\", \"gwp_asan_unittests\": \"b5d7d9ef8d6a2648f45df7d59417f69b0ca202d1\", \"interactive_ui_tests\": \"21e02cc4e5cf84649a02740ad94f5b3db645ed37\", \"ipc_tests\": \"370b3a2ba296897c5b600ea1e283f91da99ffa0a\", \"jingle_unittests\": \"05bab8c609ce2144b902a550c1eab469837f7f20\", \"keyboard_unittests\": \"0d977882654f24118aefef146c0f324dc0f1b27f\", \"latency_unittests\": \"95eb6e81eca62c413dfcba79bd2f81bc226ce24f\", \"libjingle_xmpp_unittests\": \"a82688479fb65f016dddf70695c4ab52584f7fb3\", \"media_blink_unittests\": \"dd87d3ae1878085d686eb38110442b094a7ae010\", \"media_unittests\": \"c3e88c8725b0421cbf9b82dd3220e5fba1ca9606\", \"message_center_unittests\": \"439c161851429a5c364a97c48936fe77d747f6eb\", \"midi_unittests\": \"16acc0b1cfb4936ede4bdb63a91ebf609fdec78f\", \"mojo_core_unittests\": \"7e7afab80faeea8cd191730e12003febc0b40bb0\", \"mojo_unittests\": \"b8e7cbf2237810feebf4d5efcfdf53f07f2c346c\", \"nacl_helper_nonsfi_unittests\": \"8aaa66cc36f91578b29c823599def6a02d0c732b\", \"nacl_loader_unittests\": \"93759c9ef183e6dcba3af1825adad5f394081b2a\", \"native_theme_unittests\": \"a9c402b9c219c67a6fa395eb7fff48dca5343929\", \"net_unittests\": \"fad8d4a725c266939ec458030cc0b346daeb7c34\", \"ozone_gl_unittests\": \"309200142a2245d0c740fc94933354f555a0560c\", \"ozone_unittests\": \"31351ea7de0fd19ab4d39bf0e517c81e0fdeeca2\", \"ozone_x11_unittests\": \"bdbf784765b8ff635976adf835e7adc0b0ab46d7\", \"pdf_unittests\": \"380c1a0d4a1645a5036aafc00166e10eb6184daa\", \"perfetto_unittests\": \"6c5ea4099805505ad3e7ecb807d6d4d55fd2660b\", \"ppapi_unittests\": \"190c7eece2246559c5b1818723627a7c24c86de1\", \"printing_unittests\": \"4efe758201d2b7ada08a92bf51e91a73a16e1f3a\", \"remoting_unittests\": \"0166b49a3a4368f07266c2ced9ed8ecb2705cba9\", \"sandbox_linux_unittests\": \"4d5c7f778397d7deee2f0bb737a712c24fb9da31\", \"service_manager_unittests\": \"272d7f4103cb9bafa4b0a5ce15cd83eafa7024bf\", \"services_unittests\": \"00b3ca393eef8796de13d8eda45918b7f502d691\", \"shell_dialogs_unittests\": \"1a7905dd7a421ab6705a20daf0e6e1642a467a20\", \"skia_unittests\": \"ebe3c2304a858796421fe6c71d2cb043cfdecd7e\", \"snapshot_unittests\": \"48a11b6d6167a9f369432575d231772079cda4b1\", \"sql_unittests\": \"ed0811e20c85d5eee63ec27d0e1aa7096786834e\", \"standalone_angle_unittests\": \"b1ce34f729a3eaac19dcef81ea8d55094cc843d0\", \"storage_unittests\": \"7b37e00280f3319b3011a106a33af7e6322b3819\", \"sync_integration_tests\": \"6406572cfe80f994d5023fdcf9323bfce2878470\", \"traffic_annotation_auditor_unittests\": \"00cea1ecf2f927a1b5a926dbe10d82d409390dd1\", \"ui_base_unittests\": \"148c2f7d800f4ae805ae4c0a232c7f6656ccc4d9\", \"ui_chromeos_unittests\": \"f9e2e70b27fc1ccdb8efb230be7e33e6409c1268\", \"ui_touch_selection_unittests\": \"4aad3368ce016bd255f010985b678f9efddc800b\", \"unit_tests\": \"93e91be356852cb09421909497454d77707d8e63\", \"url_unittests\": \"b24cd5c550de21d773231444c7a2b443d3191479\", \"usage_time_limit_unittests\": \"083378ef90959af4b860cd10f4cac6fbd591cc26\", \"views_unittests\": \"5b6f8071d61416371e10a80595e8ed4e42b36f76\", \"viz_unittests\": \"5c1566e508d5e4d23c810f625ac8c3639a7517ce\", \"wayland_client_perftests\": \"0fc6f7abb52eaea25e1c08d437841aa9da77f57b\", \"wm_unittests\": \"48001d5ebda3929994fe68bcc7391890e832a5f4\", \"wtf_unittests\": \"533cb5dd860894957fcd04f8f1d5836dfb8a37fb\", \"zlib_unittests\": \"4b783c4f76ac946449bc84ffbadc8b038ea44ffe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-27-4vcg\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603323451647451",
"status": "COMPLETED",
"status_changed_ts": "1603326808587491",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42158",
"builder:linux-chromeos-rel",
"buildset:commit/git/6818369fc298255ef7498d544e35d0519b28902b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6818369fc298255ef7498d544e35d0519b28902b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031217361963122048",
"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/8865787300054919344/+/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:4f6656c90daa4d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603326808689457",
"url": "https://ci.chromium.org/b/8865787300054919344",
"utcnow_ts": "1603326810578387"
}
}
[00:33:30.591] Invocation finished in 57m12.369990065s with status SUCCEEDED