[06:21:22.284] New invocation is queued and will start shortly
[06:21:23.441] Starting the invocation (attempt 1)
[06:21:23.495] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:21:23.495] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:21:23.495] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029470534961071056",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4736c3de02048014bffed546bcd993ec90c3cad7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029470534961071056",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/4736c3de02048014bffed546bcd993ec90c3cad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4736c3de02048014bffed546bcd993ec90c3cad7",
"gitiles_ref:refs/heads/master"
]
}
[06:21:24.338] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604989283654954",
"id": "8864040472861873712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4736c3de02048014bffed546bcd993ec90c3cad7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604989284138326",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42740",
"builder:linux-chromeos-rel",
"buildset:commit/git/4736c3de02048014bffed546bcd993ec90c3cad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4736c3de02048014bffed546bcd993ec90c3cad7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029470534961071056",
"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/8864040472861873712/+/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": "1604989284138581",
"url": "https://ci.chromium.org/b/8864040472861873712",
"utcnow_ts": "1604989284325451"
}
}
[06:21:24.338] Task URL: https://ci.chromium.org/b/8864040472861873712
[06:21:24.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:2:0) after 1m0s
[06:21:27.491] Received PubSub notification, asking Buildbucket for the build status
[06:21:27.561] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:24.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:2:0)
[06:22:24.417] Timer tick, asking Buildbucket for the build status
[06:22:24.520] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:24.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:4:0) after 1m0s
[06:23:24.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:4:0)
[06:23:24.634] Timer tick, asking Buildbucket for the build status
[06:23:24.695] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:24.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:5:0) after 1m0s
[06:24:24.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:5:0)
[06:24:24.757] Timer tick, asking Buildbucket for the build status
[06:24:24.827] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:24.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:6:0) after 1m0s
[06:25:24.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:6:0)
[06:25:24.833] Timer tick, asking Buildbucket for the build status
[06:25:25.042] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:25.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:7:0) after 1m0s
[06:26:25.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:7:0)
[06:26:25.093] Timer tick, asking Buildbucket for the build status
[06:26:25.188] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:25.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:8:0) after 1m0s
[06:27:25.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:8:0)
[06:27:25.232] Timer tick, asking Buildbucket for the build status
[06:27:25.343] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:25.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:9:0) after 1m0s
[06:28:25.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:9:0)
[06:28:25.378] Timer tick, asking Buildbucket for the build status
[06:28:25.456] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:25.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:10:0) after 1m0s
[06:29:25.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:10:0)
[06:29:25.521] Timer tick, asking Buildbucket for the build status
[06:29:25.651] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:25.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:11:0) after 1m0s
[06:30:25.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:11:0)
[06:30:25.677] Timer tick, asking Buildbucket for the build status
[06:30:25.739] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:25.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:12:0) after 1m0s
[06:31:25.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:12:0)
[06:31:25.759] Timer tick, asking Buildbucket for the build status
[06:31:25.831] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:25.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:13:0) after 1m0s
[06:32:25.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:13:0)
[06:32:25.871] Timer tick, asking Buildbucket for the build status
[06:32:25.972] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:14:0) after 1m0s
[06:33:25.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:14:0)
[06:33:25.993] Timer tick, asking Buildbucket for the build status
[06:33:26.072] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:26.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:15:0) after 1m0s
[06:34:26.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:15:0)
[06:34:26.099] Timer tick, asking Buildbucket for the build status
[06:34:26.204] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:26.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:16:0) after 1m0s
[06:35:26.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:16:0)
[06:35:26.263] Timer tick, asking Buildbucket for the build status
[06:35:26.382] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:26.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:17:0) after 1m0s
[06:36:26.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:17:0)
[06:36:26.461] Timer tick, asking Buildbucket for the build status
[06:36:26.556] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:26.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:18:0) after 1m0s
[06:37:26.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:18:0)
[06:37:26.615] Timer tick, asking Buildbucket for the build status
[06:37:26.747] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:26.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:19:0) after 1m0s
[06:38:26.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:19:0)
[06:38:26.756] Timer tick, asking Buildbucket for the build status
[06:38:26.928] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:26.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:20:0) after 1m0s
[06:39:26.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:20:0)
[06:39:26.965] Timer tick, asking Buildbucket for the build status
[06:39:27.200] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:21:0) after 1m0s
[06:40:27.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:21:0)
[06:40:27.258] Timer tick, asking Buildbucket for the build status
[06:40:27.805] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:27.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:22:0) after 1m0s
[06:41:27.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:22:0)
[06:41:27.858] Timer tick, asking Buildbucket for the build status
[06:41:28.301] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:28.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:23:0) after 1m0s
[06:42:28.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:23:0)
[06:42:28.392] Timer tick, asking Buildbucket for the build status
[06:42:28.455] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:28.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:24:0) after 1m0s
[06:43:28.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:24:0)
[06:43:28.556] Timer tick, asking Buildbucket for the build status
[06:43:28.832] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:28.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:25:0) after 1m0s
[06:44:28.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:25:0)
[06:44:28.817] Timer tick, asking Buildbucket for the build status
[06:44:28.890] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:28.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:26:0) after 1m0s
[06:45:28.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:26:0)
[06:45:28.920] Timer tick, asking Buildbucket for the build status
[06:45:29.079] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:29.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:27:0) after 1m0s
[06:46:29.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:27:0)
[06:46:29.109] Timer tick, asking Buildbucket for the build status
[06:46:30.342] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:30.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:28:0) after 1m0s
[06:47:30.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:28:0)
[06:47:30.367] Timer tick, asking Buildbucket for the build status
[06:47:30.434] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:30.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:29:0) after 1m0s
[06:48:30.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:29:0)
[06:48:30.462] Timer tick, asking Buildbucket for the build status
[06:48:30.580] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:30.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:30:0) after 1m0s
[06:49:30.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:30:0)
[06:49:30.634] Timer tick, asking Buildbucket for the build status
[06:49:30.702] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:30.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:31:0) after 1m0s
[06:50:30.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:31:0)
[06:50:30.760] Timer tick, asking Buildbucket for the build status
[06:50:31.126] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:31.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:32:0) after 1m0s
[06:51:31.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:32:0)
[06:51:31.154] Timer tick, asking Buildbucket for the build status
[06:51:31.569] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:31.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:33:0) after 1m0s
[06:52:31.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:33:0)
[06:52:31.617] Timer tick, asking Buildbucket for the build status
[06:52:31.673] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:31.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:34:0) after 1m0s
[06:53:31.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:34:0)
[06:53:31.717] Timer tick, asking Buildbucket for the build status
[06:53:31.786] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:31.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:35:0) after 1m0s
[06:54:31.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:35:0)
[06:54:31.839] Timer tick, asking Buildbucket for the build status
[06:54:31.893] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:31.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:36:0) after 1m0s
[06:55:31.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:36:0)
[06:55:31.967] Timer tick, asking Buildbucket for the build status
[06:55:32.330] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:32.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:37:0) after 1m0s
[06:56:32.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:37:0)
[06:56:32.391] Timer tick, asking Buildbucket for the build status
[06:56:32.502] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:32.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:38:0) after 1m0s
[06:57:32.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:38:0)
[06:57:32.588] Timer tick, asking Buildbucket for the build status
[06:57:32.674] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:32.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:39:0) after 1m0s
[06:58:32.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:39:0)
[06:58:32.707] Timer tick, asking Buildbucket for the build status
[06:58:32.767] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:32.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:40:0) after 1m0s
[06:59:32.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:40:0)
[06:59:32.819] Timer tick, asking Buildbucket for the build status
[06:59:32.874] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:32.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:41:0) after 1m0s
[07:00:32.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:41:0)
[07:00:32.899] Timer tick, asking Buildbucket for the build status
[07:00:32.948] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:32.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:42:0) after 1m0s
[07:01:32.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:42:0)
[07:01:32.937] Timer tick, asking Buildbucket for the build status
[07:01:33.044] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:33.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:43:0) after 1m0s
[07:02:34.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:43:0)
[07:02:34.334] Timer tick, asking Buildbucket for the build status
[07:02:34.749] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:34.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:44:0) after 1m0s
[07:03:35.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:44:0)
[07:03:35.060] Timer tick, asking Buildbucket for the build status
[07:03:35.122] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:35.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:45:0) after 1m0s
[07:04:35.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:45:0)
[07:04:35.142] Timer tick, asking Buildbucket for the build status
[07:04:35.247] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:35.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:46:0) after 1m0s
[07:05:35.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:46:0)
[07:05:35.395] Timer tick, asking Buildbucket for the build status
[07:05:35.501] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:35.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:47:0) after 1m0s
[07:06:35.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:47:0)
[07:06:35.691] Timer tick, asking Buildbucket for the build status
[07:06:35.810] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:35.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:48:0) after 1m0s
[07:07:35.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:48:0)
[07:07:35.849] Timer tick, asking Buildbucket for the build status
[07:07:36.135] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:36.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:49:0) after 1m0s
[07:08:36.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:49:0)
[07:08:36.434] Timer tick, asking Buildbucket for the build status
[07:08:36.627] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:36.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:50:0) after 1m0s
[07:09:36.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:50:0)
[07:09:36.684] Timer tick, asking Buildbucket for the build status
[07:09:36.827] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:36.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:51:0) after 1m0s
[07:10:36.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:51:0)
[07:10:36.887] Timer tick, asking Buildbucket for the build status
[07:10:37.018] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:37.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:52:0) after 1m0s
[07:11:37.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:52:0)
[07:11:37.194] Timer tick, asking Buildbucket for the build status
[07:11:37.445] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:37.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:53:0) after 1m0s
[07:12:37.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:53:0)
[07:12:37.632] Timer tick, asking Buildbucket for the build status
[07:12:37.911] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:37.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:54:0) after 1m0s
[07:13:38.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:54:0)
[07:13:38.055] Timer tick, asking Buildbucket for the build status
[07:13:38.170] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:38.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:55:0) after 1m0s
[07:14:38.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:55:0)
[07:14:38.218] Timer tick, asking Buildbucket for the build status
[07:14:45.515] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:45.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:56:0) after 1m0s
[07:15:45.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:56:0)
[07:15:45.580] Timer tick, asking Buildbucket for the build status
[07:15:45.694] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:45.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:57:0) after 1m0s
[07:16:45.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:57:0)
[07:16:45.754] Timer tick, asking Buildbucket for the build status
[07:16:46.059] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:46.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:58:0) after 1m0s
[07:17:46.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:58:0)
[07:17:46.177] Timer tick, asking Buildbucket for the build status
[07:17:46.309] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:46.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:59:0) after 1m0s
[07:18:46.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:59:0)
[07:18:46.393] Timer tick, asking Buildbucket for the build status
[07:18:47.057] Build 8864040472861873712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:47.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029470534961071056:60:0) after 1m0s
[07:19:14.676] Received PubSub notification, asking Buildbucket for the build status
[07:19:14.750] Build 8864040472861873712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:19:14.751] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604992752148999",
"created_by": "project:chromium",
"created_ts": "1604989283654954",
"id": "8864040472861873712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4736c3de02048014bffed546bcd993ec90c3cad7\"}}",
"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\": \"4736c3de02048014bffed546bcd993ec90c3cad7\", \"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-central1-b-8-203-uj3r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42740, \"got_angle_revision\": \"528ae31edd58f95fac1cba36866b7b477a97f5a0\", \"got_dawn_revision\": \"c04a0132be6c384c90bd33b06929a9b7fc5d4726\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"4736c3de02048014bffed546bcd993ec90c3cad7\", \"got_revision_cp\": \"refs/heads/master@{#825693}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"0833ef4127bc532629c6a7952fb8b18ffaa95e85\", \"got_v8_revision_cp\": \"refs/heads/8.8.269@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4736c3de02048014bffed546bcd993ec90c3cad7\", \"swarm_hashes_refs/heads/master(at){#825693}_without_patch\": {\"absl_hardening_tests\": \"8547d3de1ac26f71562075c856ea9c705a62ba90\", \"accessibility_unittests\": \"376176bc97fc4d133de762e3f5c61babcf395a55\", \"angle_unittests\": \"f45933575689652e24915de244e153e08b716e8d\", \"app_list_unittests\": \"aea409785ef5b11ff28a0b8d016bceb7cb559e97\", \"app_shell_unittests\": \"7a6397746de8d5d5f20fb146f45358f76b8824ed\", \"ash_unittests\": \"154a4fabcbd6f89b2d3c87a877ff685e9167071b\", \"aura_unittests\": \"64829f5b0352c750b1fd88a061aeb14434c09b77\", \"base_unittests\": \"3be55af79805c7abb2c7575d94845499fa744c09\", \"base_util_unittests\": \"95450d67db5496f5460c894153bdcbee878133c5\", \"blink_common_unittests\": \"66483a5c2735e0778f6b5d1bc638ef0d4076ad2c\", \"blink_fuzzer_unittests\": \"7a09f46f852bf2fa81601156f5db3de782223e5f\", \"blink_heap_unittests\": \"e0875f245f121d883c38d5c528e633597935191f\", \"blink_platform_unittests\": \"122af41a8034b6d150fc5fc51d0b87d9f121dc67\", \"blink_unittests\": \"d4ed906a00b523e864222abe6805b4163e24020f\", \"boringssl_crypto_tests\": \"20920e9e0cfa05026c39cd1e635e56891d3e76ee\", \"boringssl_ssl_tests\": \"740475c5884e21d92a5301241932bbe5320021b6\", \"browser_tests\": \"9c8f0a948e39b79cfb9c8188424c207572ccc388\", \"capture_unittests\": \"528133119cb0093002fd8d376fd556b603a6e35d\", \"cast_unittests\": \"72af5fd9e8e347110a9322c90f4f441794192d8e\", \"cc_unittests\": \"283e3d06b5dd14b7279d425ee418505199f13ec9\", \"chrome_app_unittests\": \"2227c09021066becd02e16c83e69b7f989b6d7be\", \"chromedriver_unittests\": \"db93291c91582fd561f4948f0291e3fc86cdfe01\", \"chromeos_components_unittests\": \"5c1a334aa7a303a0d1acc7b187b253b5dad46a15\", \"chromeos_unittests\": \"179c6a82de287a6310f56a8f7701bb7da0d4b541\", \"components_browsertests\": \"53b0fda3f4282fbc5d09b3cf3b96011a3946d5fa\", \"components_unittests\": \"a67e1881b5f82c929ac546607d6d279196d558ef\", \"compositor_unittests\": \"0ccedf8237a0f86307496e21b7f6459631fabbc4\", \"content_browsertests\": \"999777e47fb480c116549bbb6a016b1eb83a7948\", \"content_unittests\": \"1b1fee27f06a6c5670c1a2d0976a75f3785e8588\", \"crypto_unittests\": \"f6f79d1a5405b908697167a82b7a0a47432a07f7\", \"dbus_unittests\": \"c0bb2c7be495861507ed6afd367c058d1083fb25\", \"device_unittests\": \"e4e875cd7e62c11312b87deac69446e4a01b9542\", \"display_unittests\": \"0d67595edc19afb3768f8b467b6697b550b330f7\", \"events_unittests\": \"aa4c7a733361ba7bd77d446a88456de721b3a16d\", \"exo_unittests\": \"1b31345004bc9a83460e9cb147d2d07b0d78327a\", \"extensions_browsertests\": \"fbd68cb37f60e8c13260b1d23fa87140ccd8e02f\", \"extensions_unittests\": \"5b3c3688e6b3c395e397ffbd5d9cd0fca7b64623\", \"filesystem_service_unittests\": \"802dad83894bd56f94bb191980c847391c466ba5\", \"gcm_unit_tests\": \"f3d1e5be46b7ee4ada078341df848c519b6b640f\", \"gfx_unittests\": \"47746c415c8dcb876a9f33c2d8bda0fe69f2dd02\", \"gin_unittests\": \"ccb5582196e9d3e527dfb4851b7054d4cf8da1c6\", \"gl_unittests_ozone\": \"22095030e1577ba1216b10cfe65cd1bf5a5df745\", \"google_apis_unittests\": \"6d5064a4db4c156dc6c1dd35def0eb17881c7856\", \"gpu_unittests\": \"709302b42979b5fc090574616efdb46120828ecb\", \"gwp_asan_unittests\": \"7649616c8a921c694ac0097b0d860130921e1216\", \"interactive_ui_tests\": \"5ed4c8e90b9445cea99de88c4c268933f1a39595\", \"ipc_tests\": \"a78f39e8efbd2cf4aeea4ca88036c8608bf382d9\", \"jingle_unittests\": \"24151e9a45fa8aad61557e62929f3d46a48289bd\", \"keyboard_unittests\": \"e5cae4f56df99c115cae93fcb76d73d254aaaf06\", \"latency_unittests\": \"1a1a380c543e2374bac2bbe7d45ce12a15d1ca80\", \"libjingle_xmpp_unittests\": \"aa880c887b0ee24d2e0ccfbb60f4b801a9f7fcb4\", \"liburlpattern_unittests\": \"9e2212d1d95f7c06d074a4847d2be7f643499a51\", \"media_blink_unittests\": \"e66dea805a9b5b4c0ce8c6410cf1fe2ad711d7e3\", \"media_unittests\": \"ab2bd47a71a40aaabf2f9280a3158445d8ded0d2\", \"message_center_unittests\": \"e67e804c48ff66ad502588f7534b4a6138a35bf0\", \"midi_unittests\": \"fe8720859b9de986076e7e1e442675dfdd12ff88\", \"mojo_core_unittests\": \"6f808b96ad6f2f914cd0332d58b5720a2dbceb70\", \"mojo_unittests\": \"66064dd2b2cabb236aabcf98c0952277d37bef72\", \"nacl_helper_nonsfi_unittests\": \"2a31f7dcd2379b705e2a451804e291c01de7321b\", \"nacl_loader_unittests\": \"282b5fad0a9f1e27a9bbc54a28673f3e91b3a036\", \"native_theme_unittests\": \"15e2ab23414c1dc09db1522ab0e4a59cf7db0abf\", \"net_unittests\": \"0b824c7d53d3d78d727c42a0544faa150f5ad2c0\", \"ozone_gl_unittests\": \"87a213f9add79466d15ba6d05e7993fa476e3b24\", \"ozone_unittests\": \"ffda2be6c084bbe660405ec3bcd154cc6dec2d67\", \"ozone_x11_unittests\": \"45e715713aba990d3fbcbbd2c6e9da58503aa4c8\", \"pdf_unittests\": \"bd772cd99ff26827f83f4388d3cd41ebb1d6f2ff\", \"perfetto_unittests\": \"5d41dace6d3c5e17ec1a6fe363884cd303fa1d36\", \"ppapi_unittests\": \"f36cf116c59e9b05a6cda0d13e90b7c895cfe56d\", \"printing_unittests\": \"7ac1621b2bf24dfe6c23280f9454574555f98ee8\", \"remoting_unittests\": \"4c79d9551172fd50fedf0a94681304228d9e5a1c\", \"sandbox_linux_unittests\": \"c22e116ef96cc1f01e4d1f32ecf4f5c12a30af30\", \"service_manager_unittests\": \"92e4162d5cf1b780152c7e4c6c13a8c9067dc28a\", \"services_unittests\": \"37e7c50a1559dbcf901876c05c2fbb150594fd1c\", \"shell_dialogs_unittests\": \"08f3598efb4426be4b7bb9e5d942ad5517f36803\", \"skia_unittests\": \"7a0601064984653b7ae1f95c7e22cd5d8142e9fc\", \"snapshot_unittests\": \"3e24392bdf156fdcc1b378c44f2ca5abec69f593\", \"sql_unittests\": \"10b2059f001a89cf93957e73f384aa4234a418a2\", \"storage_unittests\": \"6c65ff624a0a6be1c52122801aab527774c149de\", \"sync_integration_tests\": \"a063f7b529f8f688d2c65cab6cc76159a6eec1f9\", \"traffic_annotation_auditor_unittests\": \"b241b8a65f385f77c66ecc35f4619f5a84b8d884\", \"ui_base_unittests\": \"b332e9394c7714a5f421cb29d2b41cbf58ee7810\", \"ui_chromeos_unittests\": \"b5d7e123ebbe0ad57a95fd0ba0991d224d2f9f5f\", \"ui_touch_selection_unittests\": \"8de69cd8caed5be8e0b4d5daa30384f401ff6f7e\", \"unit_tests\": \"1ec9cdb9d70da71205b9942d2972548e7ee1633e\", \"url_unittests\": \"254b7bf7716a8e2869432913bfbb25a7d6ea4d21\", \"usage_time_limit_unittests\": \"0e820cf7ba4afb3cd9178eae7a5a658c0eda236d\", \"views_unittests\": \"add916d3e3ac595846346396f0e8dc16e3c80e5c\", \"viz_unittests\": \"642e2f48888c1c57b7409bec0f64d68aac3d3f46\", \"wayland_client_perftests\": \"e726c436ad36d5e01b1688209071273a90ee843e\", \"wm_unittests\": \"11b402fad6751dfaf9cb99dba847490951ff72cb\", \"wtf_unittests\": \"4e3536dea4585617e65c1b735cb3c73ef11f97b9\", \"zlib_unittests\": \"b70c0945aa2dc313df3b16efbe2732e6b2c42d6a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0eb0a6f6f49375c133e7af8048caaf1812a31b1811f4b52b8753fe729d0821de_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_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-central1-b-8-203-uj3r\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604989286697414",
"status": "COMPLETED",
"status_changed_ts": "1604992752426746",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42740",
"builder:linux-chromeos-rel",
"buildset:commit/git/4736c3de02048014bffed546bcd993ec90c3cad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4736c3de02048014bffed546bcd993ec90c3cad7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029470534961071056",
"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/8864040472861873712/+/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:4fc9a2789cb89710",
"user_agent:luci-scheduler"
],
"updated_ts": "1604992752454372",
"url": "https://ci.chromium.org/b/8864040472861873712",
"utcnow_ts": "1604992754740099"
}
}
[07:19:14.751] Invocation finished in 57m52.483013416s with status SUCCEEDED