[11:03:44.582] New invocation is queued and will start shortly
[11:03:45.791] Starting the invocation (attempt 1)
[11:03:45.832] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:03:45.832] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:03:45.833] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019305909445586272",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019305909445586272",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6",
"gitiles_ref:refs/heads/master"
]
}
[11:03:47.491] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614683026783494",
"id": "8853875846466400048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614683027250236",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45838",
"builder:linux-chromeos-rel",
"buildset:commit/git/f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019305909445586272",
"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/8853875846466400048/+/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": "1614683027250396",
"url": "https://ci.chromium.org/b/8853875846466400048",
"utcnow_ts": "1614683027479992"
}
}
[11:03:47.491] Task URL: https://ci.chromium.org/b/8853875846466400048
[11:03:47.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:2:0) after 1m0s
[11:04:11.219] Received PubSub notification, asking Buildbucket for the build status
[11:04:11.273] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:47.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:2:0)
[11:04:47.529] Timer tick, asking Buildbucket for the build status
[11:04:47.607] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:47.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:4:0) after 1m0s
[11:05:47.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:4:0)
[11:05:47.626] Timer tick, asking Buildbucket for the build status
[11:05:47.680] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:47.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:5:0) after 1m0s
[11:06:47.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:5:0)
[11:06:47.655] Timer tick, asking Buildbucket for the build status
[11:06:47.841] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:47.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:6:0) after 1m0s
[11:07:48.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:6:0)
[11:07:48.126] Timer tick, asking Buildbucket for the build status
[11:07:48.198] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:48.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:7:0) after 1m0s
[11:08:48.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:7:0)
[11:08:48.330] Timer tick, asking Buildbucket for the build status
[11:08:48.421] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:48.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:8:0) after 1m0s
[11:09:48.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:8:0)
[11:09:48.448] Timer tick, asking Buildbucket for the build status
[11:09:48.509] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:48.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:9:0) after 1m0s
[11:10:48.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:9:0)
[11:10:48.563] Timer tick, asking Buildbucket for the build status
[11:10:48.666] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:48.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:10:0) after 1m0s
[11:11:55.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:10:0)
[11:11:55.202] Timer tick, asking Buildbucket for the build status
[11:11:55.273] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:55.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:11:0) after 1m0s
[11:12:55.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:11:0)
[11:12:55.380] Timer tick, asking Buildbucket for the build status
[11:12:55.461] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:55.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:12:0) after 1m0s
[11:13:55.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:12:0)
[11:13:55.525] Timer tick, asking Buildbucket for the build status
[11:13:55.609] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:55.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:13:0) after 1m0s
[11:14:55.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:13:0)
[11:14:55.712] Timer tick, asking Buildbucket for the build status
[11:14:55.781] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:55.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:14:0) after 1m0s
[11:15:55.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:14:0)
[11:15:55.923] Timer tick, asking Buildbucket for the build status
[11:15:55.987] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:55.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:15:0) after 1m0s
[11:16:56.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:15:0)
[11:16:56.007] Timer tick, asking Buildbucket for the build status
[11:16:56.336] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:56.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:16:0) after 1m0s
[11:17:56.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:16:0)
[11:17:56.464] Timer tick, asking Buildbucket for the build status
[11:17:56.548] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:56.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:17:0) after 1m0s
[11:18:56.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:17:0)
[11:18:56.565] Timer tick, asking Buildbucket for the build status
[11:18:56.632] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:56.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:18:0) after 1m0s
[11:19:56.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:18:0)
[11:19:56.671] Timer tick, asking Buildbucket for the build status
[11:19:56.856] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:56.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:19:0) after 1m0s
[11:20:56.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:19:0)
[11:20:56.838] Timer tick, asking Buildbucket for the build status
[11:20:57.034] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:57.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:20:0) after 1m0s
[11:21:57.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:20:0)
[11:21:57.054] Timer tick, asking Buildbucket for the build status
[11:21:57.132] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:57.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:21:0) after 1m0s
[11:22:57.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:21:0)
[11:22:57.149] Timer tick, asking Buildbucket for the build status
[11:22:57.953] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:57.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:22:0) after 1m0s
[11:23:58.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:22:0)
[11:23:58.002] Timer tick, asking Buildbucket for the build status
[11:23:58.207] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:58.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:23:0) after 1m0s
[11:24:58.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:23:0)
[11:24:58.223] Timer tick, asking Buildbucket for the build status
[11:24:58.294] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:58.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:24:0) after 1m0s
[11:25:58.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:24:0)
[11:25:58.282] Timer tick, asking Buildbucket for the build status
[11:25:58.347] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:58.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:25:0) after 1m0s
[11:26:58.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:25:0)
[11:26:58.369] Timer tick, asking Buildbucket for the build status
[11:26:58.435] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:58.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:26:0) after 1m0s
[11:27:58.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:26:0)
[11:27:58.405] Timer tick, asking Buildbucket for the build status
[11:27:58.926] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:58.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:27:0) after 1m0s
[11:28:58.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:27:0)
[11:28:58.941] Timer tick, asking Buildbucket for the build status
[11:28:59.065] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:59.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:28:0) after 1m0s
[11:29:59.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:28:0)
[11:29:59.082] Timer tick, asking Buildbucket for the build status
[11:29:59.150] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:59.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:29:0) after 1m0s
[11:30:59.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:29:0)
[11:30:59.208] Timer tick, asking Buildbucket for the build status
[11:30:59.451] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:59.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:30:0) after 1m0s
[11:31:59.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:30:0)
[11:31:59.517] Timer tick, asking Buildbucket for the build status
[11:32:00.149] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:00.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:31:0) after 1m0s
[11:33:00.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:31:0)
[11:33:00.168] Timer tick, asking Buildbucket for the build status
[11:33:00.469] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:00.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:32:0) after 1m0s
[11:34:00.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:32:0)
[11:34:00.500] Timer tick, asking Buildbucket for the build status
[11:34:00.802] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:00.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:33:0) after 1m0s
[11:35:00.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:33:0)
[11:35:00.828] Timer tick, asking Buildbucket for the build status
[11:35:00.900] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:00.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:34:0) after 1m0s
[11:36:01.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:34:0)
[11:36:01.476] Timer tick, asking Buildbucket for the build status
[11:36:01.644] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:01.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:35:0) after 1m0s
[11:37:01.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:35:0)
[11:37:01.662] Timer tick, asking Buildbucket for the build status
[11:37:02.972] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:02.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:36:0) after 1m0s
[11:38:03.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:36:0)
[11:38:03.020] Timer tick, asking Buildbucket for the build status
[11:38:03.088] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:03.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:37:0) after 1m0s
[11:39:03.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:37:0)
[11:39:03.108] Timer tick, asking Buildbucket for the build status
[11:39:03.181] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:03.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:38:0) after 1m0s
[11:40:03.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:38:0)
[11:40:03.247] Timer tick, asking Buildbucket for the build status
[11:40:03.328] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:03.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:39:0) after 1m0s
[11:41:03.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:39:0)
[11:41:03.333] Timer tick, asking Buildbucket for the build status
[11:41:03.429] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:03.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:40:0) after 1m0s
[11:42:03.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:40:0)
[11:42:03.435] Timer tick, asking Buildbucket for the build status
[11:42:03.627] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:03.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:41:0) after 1m0s
[11:43:03.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:41:0)
[11:43:03.643] Timer tick, asking Buildbucket for the build status
[11:43:03.759] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:03.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:42:0) after 1m0s
[11:44:03.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:42:0)
[11:44:03.796] Timer tick, asking Buildbucket for the build status
[11:44:03.873] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:03.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:43:0) after 1m0s
[11:45:03.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:43:0)
[11:45:03.917] Timer tick, asking Buildbucket for the build status
[11:45:04.050] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:04.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:44:0) after 1m0s
[11:46:04.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:44:0)
[11:46:04.071] Timer tick, asking Buildbucket for the build status
[11:46:04.168] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:04.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:45:0) after 1m0s
[11:47:04.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:45:0)
[11:47:04.212] Timer tick, asking Buildbucket for the build status
[11:47:04.376] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:04.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:46:0) after 1m0s
[11:48:04.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:46:0)
[11:48:04.390] Timer tick, asking Buildbucket for the build status
[11:48:05.484] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:05.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:47:0) after 1m0s
[11:49:05.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:47:0)
[11:49:05.525] Timer tick, asking Buildbucket for the build status
[11:49:05.601] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:05.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:48:0) after 1m0s
[11:50:05.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:48:0)
[11:50:05.746] Timer tick, asking Buildbucket for the build status
[11:50:05.834] Build 8853875846466400048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:05.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019305909445586272:49:0) after 1m0s
[11:50:17.031] Received PubSub notification, asking Buildbucket for the build status
[11:50:17.172] Build 8853875846466400048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:50:17.172] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614685813825322",
"created_by": "project:chromium",
"created_ts": "1614683026783494",
"id": "8853875846466400048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6\"}}",
"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\": \"f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6\", \"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-71-pwuo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45838, \"got_angle_revision\": \"6b6da203cce03287ef269846d54e77a8e871e221\", \"got_dawn_revision\": \"ec3f48242250668ca510ceef7336cf93ba80faa5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6\", \"got_revision_cp\": \"refs/heads/master@{#858953}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"e354dd1ed9d1e7e05e1365116b09a5a232ae8a86\", \"got_v8_revision_cp\": \"refs/heads/9.1.13@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6\", \"swarm_hashes_refs/heads/master(at){#858953}_without_patch\": {\"absl_hardening_tests\": \"929f1dde61f4931e84a4b19754cd1027252ac611\", \"accessibility_unittests\": \"b3ab056e7856bcace4f9cb3205d3fd563f2949fa\", \"angle_unittests\": \"df1522fa122c7c4d1daad727296c6a46069eaf25\", \"app_list_unittests\": \"a7e74c9ac6f484ec47c6cedac867a1b30fb5047c\", \"app_shell_unittests\": \"e2e11acc41cd3c7983a84f5c408fa6bef85899f6\", \"ash_unittests\": \"76eea4fc9d29ddf6e0c202e340d194530e5d0c64\", \"aura_unittests\": \"668eea64402a27db3fcace02e9c912fbefb2d2b4\", \"base_unittests\": \"1f5cf45c56148d75f383000796e6a8ba10f76b1f\", \"base_util_unittests\": \"0dd851d2afa0cad8057e4bdbc393e4c3670384fd\", \"blink_common_unittests\": \"2373c1a3f6db9f9e57f2cc4a78407dfb53596203\", \"blink_fuzzer_unittests\": \"1fc07ab29247ce434042748c58ba9a772430d040\", \"blink_heap_unittests\": \"866ae42d71874d7e9a99dd527e7455ba1e9b534e\", \"blink_platform_unittests\": \"62f6a7cb0fd5a625c44a1ad77f0d9a7c872213e3\", \"blink_unittests\": \"c15e32b87f555243aff2a958f25b4157c93ce3d0\", \"boringssl_crypto_tests\": \"8e2626ab5eb4370588c3984c824c39e4f7ceb574\", \"boringssl_ssl_tests\": \"bf6b02cf686f5d709e645836264e6cfd4f9a0eec\", \"browser_tests\": \"11ebd2710152125a0e5c941604c2e1c5ef02781a\", \"capture_unittests\": \"6adb17f08ec60ac4ffcef36560f127707d339499\", \"cast_unittests\": \"305e6083892597d60b38994c52a7112952da4f8c\", \"cc_unittests\": \"7658148879cbf0812905ba7f7eb89461cce66750\", \"chrome_app_unittests\": \"143392b19752a5681282947520a085906f118083\", \"chromedriver_unittests\": \"f5e9c72fdf2a7e74123165ac37198f7c2a3a7b96\", \"chromeos_components_unittests\": \"caa5931a792da42e8b8b4f15f7732231c9faaaea\", \"chromeos_unittests\": \"e53ffcff7bb54761555cec9956836ff07df2190f\", \"color_unittests\": \"6518720462877c3c5f278bc6d331fc8526880a1b\", \"components_browsertests\": \"ac4a639718919eb557a34e3554034057d09dd246\", \"components_unittests\": \"533a4962c3504f82d35d516fbb4c61c8fdae1320\", \"compositor_unittests\": \"240bcc3c7ea0d2a2138ec29a763db7a44224369c\", \"content_browsertests\": \"ee7a9b83c7d5dc04958273a6e8577f8e8fca452e\", \"content_unittests\": \"2f032932912defa899ba152f00e9121870e50180\", \"crashpad_tests\": \"8f34f540ea96b552deeab0254a4a3a3cf738f5f6\", \"crypto_unittests\": \"d618c14b8452a9f66bedf5476b172aaf53bfb8c3\", \"dbus_unittests\": \"ceb1cf698059f7528a70fa4bdd44f88409767be1\", \"device_unittests\": \"ff10f9700f18edc649ace0ac56dea15a523fbcba\", \"display_unittests\": \"2bb9ec23d2ab577a8166f4df29fdaa039fc87dd9\", \"events_unittests\": \"09e50b1a86af32aa310bace3dbabe4eae45a4a6e\", \"exo_unittests\": \"f57e9f9f47c5496ea4cb2abe0b450aef1b91823d\", \"extensions_browsertests\": \"9fb91ee291e4fc7c8f44e04e383824585bf7eb6c\", \"extensions_unittests\": \"4a4d5709dbc0fda67d12f6cd7e5d131fc008d22d\", \"filesystem_service_unittests\": \"776468dae24682c1351b42f2cf4d2d7132c2bdbd\", \"gcm_unit_tests\": \"755a58b2779eadff7f23efbac9b0de3e095f7bb4\", \"gfx_unittests\": \"50e522b467afbcf026f64d85b74f088fcf9d270e\", \"gin_unittests\": \"1bdc3861ee43807b159e3347141c484322619c0b\", \"gl_unittests_ozone\": \"01c390b0e40721c76bb2fff8071fc3899156183e\", \"google_apis_unittests\": \"f5c5ac71395ec3c820379da36e37e3b5576ccdbe\", \"gpu_unittests\": \"79588fd2f659963ffc37bdf08bac3325bb43198b\", \"gwp_asan_unittests\": \"c31e2696715d84e96d74151aca1b3a542d69a003\", \"interactive_ui_tests\": \"5a8c960e7f0d0915c4d8ccf66d8a14732e78f9ca\", \"ipc_tests\": \"9fb28a749976cb1585747bd8ccf26a505837a455\", \"jingle_unittests\": \"d1bab6361824f554247d7c8cdad5bad6782ef5c6\", \"keyboard_unittests\": \"ecbf3151ede46a09485ea7b0916df40d0f042fc5\", \"latency_unittests\": \"899e43eb37ef72088d4b8736bcb5bad57d5e4d35\", \"libjingle_xmpp_unittests\": \"1273fd6ffd72e58d2f89ddd0fccb34842fd29b4e\", \"liburlpattern_unittests\": \"e4eb0233fc6b48447eb6b77ffabf93d9e3d7fabf\", \"media_blink_unittests\": \"e438f7c448fd2fd6794d8d88e974530cbe65c1ae\", \"media_unittests\": \"6fc4461b5834df09389d818d235fa4b9b1debc4f\", \"message_center_unittests\": \"dd855858162554aabecd855962ddb824dab6cb83\", \"midi_unittests\": \"5341be1a104491272787a4cbedd00d8edfc3a9fa\", \"mojo_core_unittests\": \"a4d9bb6cb50fd2464a6988883a6e26c1c203c4a3\", \"mojo_unittests\": \"9d9f085162efef1ad698a4ceba7d299c505f409b\", \"nacl_helper_nonsfi_unittests\": \"962a7e9af637643d6fb2d76177574d7c37bb8b6e\", \"nacl_loader_unittests\": \"ef339ba28f4bd5370acc25860ba1a53be0371cd0\", \"native_theme_unittests\": \"d048b60b3b759ca0d7bff40ac63f63d0b952f1d7\", \"net_unittests\": \"728b5b7ae0e847b45b21669a097119744355bb2f\", \"ozone_gl_unittests\": \"f1cf7e819257882cfe52ba10a45c6614b9a4ae01\", \"ozone_unittests\": \"aa55ab1c9bba4c31fb0f9554b70641c0dfd7e469\", \"ozone_x11_unittests\": \"89bb65116ddf9e2b870d9924b79f32820a63b299\", \"pdf_unittests\": \"8a5b2213869086fc3d055e0642f23e625b8a3c94\", \"perfetto_unittests\": \"9fbee8f815ce6e7b13fe926d2dbddd1a2950c28e\", \"ppapi_unittests\": \"d1b081ef4e20e5f4d6af4be472420407b91bce7c\", \"printing_unittests\": \"e0e4d9e5cabf7f14ea7f4e4ba800535f312d408d\", \"remoting_unittests\": \"06b49f652442a85bd8468854c0e2392d0ee29b3c\", \"sandbox_linux_unittests\": \"e6ffe02aa4b2724c7ecaa72d213344eda1fb5f7a\", \"service_manager_unittests\": \"2099ce6d684286a6df0d26514ce0b1b4b35d4f4d\", \"services_unittests\": \"a9fccdd661e15fdf7b5897cdd446025b223fbd9a\", \"shell_dialogs_unittests\": \"05f1c088ac162a80a33a908675ddc7c02fbe7a27\", \"shell_encryption_unittests\": \"985353019a6e903e741adfe896a93b991af5c0e3\", \"skia_unittests\": \"d5debb7149d7ef87b89c286c0c92ff099a15b955\", \"snapshot_unittests\": \"c09ba95754a507e7e352fbf7adf9a89a4edb2fed\", \"sql_unittests\": \"188bbd4d7ae0536ac8c64f69765838ec91d03ea7\", \"storage_unittests\": \"c13673af302b36e1d94326c4fef4a793c14c5b0a\", \"sync_integration_tests\": \"1cefad89f49a4e66a1ca6cfc4d9e8ed2c92a140e\", \"traffic_annotation_auditor_unittests\": \"b5bd167184cbe8bc0fe0c36a2d51172684dbcf1b\", \"ui_base_unittests\": \"96cfc1372d3def8a73705c6d6118f3f0c50834eb\", \"ui_chromeos_unittests\": \"031de3d026aad8d7007ebefa0973613f4af60f6b\", \"ui_touch_selection_unittests\": \"d0ecbffdb71c4298c8d7934cc44d50574322b7c7\", \"unit_tests\": \"694fa48a3799de7384b3a9588cd351fa2968491d\", \"url_unittests\": \"fe452c3ea410d6a058a00d48b7370d9b557f494e\", \"usage_time_limit_unittests\": \"99ba512483c97a2734095d7fbf14b41afc5f3a17\", \"views_unittests\": \"b093114742cac5654c7d647de3e53d6869944d81\", \"viz_unittests\": \"2d3d9b214b5c8208bb1eff11c925b02f2ee995ba\", \"wayland_client_perftests\": \"1e3b868cd7855f193f536fa208bb71d342b0590b\", \"wayland_client_tests\": \"3a1f92e0ae4168b456d71e9d9e1be8f24d139055\", \"wm_unittests\": \"21bd6d0d537b48dd42c04554bc258bf4c5030d06\", \"wtf_unittests\": \"197b9d49d94a65c26f3afdc51b1549fe11fae06d\", \"zlib_unittests\": \"26f811adb430e92efed4c3ad17ef711909680cf6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_7e0fd5fb59bce9eac4ec1dec14c7ab059c08dcb0c6471580f0ba0fe000c8167b_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_c0379f96998ef0ae805f9cba371bee413f8de83d71b7accc592dcc5afbbc3b2d_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-71-pwuo\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614683049791291",
"status": "COMPLETED",
"status_changed_ts": "1614685814258935",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45838",
"builder:linux-chromeos-rel",
"buildset:commit/git/f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f5e1f7ff3fdeec6f147238a8d2079c30aa2c70d6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019305909445586272",
"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/8853875846466400048/+/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:520b6d40d4f0ed10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614685814326911",
"url": "https://ci.chromium.org/b/8853875846466400048",
"utcnow_ts": "1614685817160376"
}
}
[11:50:17.172] Invocation finished in 46m32.613649869s with status SUCCEEDED