[22:30:23.300] New invocation is queued and will start shortly
[22:30:24.432] Starting the invocation (attempt 1)
[22:30:24.465] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:30:24.465] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:30:24.465] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019896888214574384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019896888214574384",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4",
"gitiles_ref:refs/heads/master"
]
}
[22:30:25.926] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614119424600018",
"id": "8854466826188559168",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614119425684103",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45675",
"builder:linux-chromeos-rel",
"buildset:commit/git/3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019896888214574384",
"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/8854466826188559168/+/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": "1614119425684230",
"url": "https://ci.chromium.org/b/8854466826188559168",
"utcnow_ts": "1614119425914598"
}
}
[22:30:25.926] Task URL: https://ci.chromium.org/b/8854466826188559168
[22:30:25.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:2:0) after 1m0s
[22:30:31.077] Received PubSub notification, asking Buildbucket for the build status
[22:30:31.191] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:25.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:2:0)
[22:31:25.920] Timer tick, asking Buildbucket for the build status
[22:31:26.001] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:26.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:4:0) after 1m0s
[22:32:26.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:4:0)
[22:32:26.001] Timer tick, asking Buildbucket for the build status
[22:32:26.201] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:26.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:5:0) after 1m0s
[22:33:26.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:5:0)
[22:33:26.218] Timer tick, asking Buildbucket for the build status
[22:33:26.488] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:26.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:6:0) after 1m0s
[22:34:26.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:6:0)
[22:34:26.523] Timer tick, asking Buildbucket for the build status
[22:34:26.625] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:26.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:7:0) after 1m0s
[22:35:26.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:7:0)
[22:35:26.613] Timer tick, asking Buildbucket for the build status
[22:35:26.947] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:26.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:8:0) after 1m0s
[22:36:26.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:8:0)
[22:36:26.956] Timer tick, asking Buildbucket for the build status
[22:36:27.407] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:27.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:9:0) after 1m0s
[22:37:27.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:9:0)
[22:37:27.411] Timer tick, asking Buildbucket for the build status
[22:37:27.481] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:27.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:10:0) after 1m0s
[22:38:27.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:10:0)
[22:38:27.537] Timer tick, asking Buildbucket for the build status
[22:38:27.632] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:27.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:11:0) after 1m0s
[22:39:27.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:11:0)
[22:39:27.664] Timer tick, asking Buildbucket for the build status
[22:39:27.775] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:27.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:12:0) after 1m0s
[22:40:27.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:12:0)
[22:40:27.792] Timer tick, asking Buildbucket for the build status
[22:40:28.130] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:28.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:13:0) after 1m0s
[22:41:28.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:13:0)
[22:41:28.124] Timer tick, asking Buildbucket for the build status
[22:41:28.253] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:28.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:14:0) after 1m0s
[22:42:28.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:14:0)
[22:42:28.297] Timer tick, asking Buildbucket for the build status
[22:42:28.395] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:28.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:15:0) after 1m0s
[22:43:28.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:15:0)
[22:43:28.411] Timer tick, asking Buildbucket for the build status
[22:43:28.533] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:28.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:16:0) after 1m0s
[22:44:28.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:16:0)
[22:44:28.550] Timer tick, asking Buildbucket for the build status
[22:44:28.733] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:28.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:17:0) after 1m0s
[22:45:28.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:17:0)
[22:45:28.785] Timer tick, asking Buildbucket for the build status
[22:45:28.875] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:28.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:18:0) after 1m0s
[22:46:28.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:18:0)
[22:46:28.921] Timer tick, asking Buildbucket for the build status
[22:46:29.021] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:29.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:19:0) after 1m0s
[22:47:29.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:19:0)
[22:47:29.099] Timer tick, asking Buildbucket for the build status
[22:47:29.415] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:29.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:20:0) after 1m0s
[22:48:29.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:20:0)
[22:48:29.431] Timer tick, asking Buildbucket for the build status
[22:48:29.502] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:29.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:21:0) after 1m0s
[22:49:29.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:21:0)
[22:49:29.614] Timer tick, asking Buildbucket for the build status
[22:49:29.735] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:29.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:22:0) after 1m0s
[22:50:29.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:22:0)
[22:50:29.816] Timer tick, asking Buildbucket for the build status
[22:50:30.017] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:30.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:23:0) after 1m0s
[22:51:30.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:23:0)
[22:51:30.081] Timer tick, asking Buildbucket for the build status
[22:51:30.682] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:30.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:24:0) after 1m0s
[22:52:30.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:24:0)
[22:52:30.703] Timer tick, asking Buildbucket for the build status
[22:52:30.767] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:30.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:25:0) after 1m0s
[22:53:30.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:25:0)
[22:53:30.822] Timer tick, asking Buildbucket for the build status
[22:53:30.901] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:30.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:26:0) after 1m0s
[22:54:31.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:26:0)
[22:54:31.187] Timer tick, asking Buildbucket for the build status
[22:54:31.256] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:31.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:27:0) after 1m0s
[22:55:31.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:27:0)
[22:55:31.351] Timer tick, asking Buildbucket for the build status
[22:55:31.513] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:31.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:28:0) after 1m0s
[22:56:31.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:28:0)
[22:56:31.560] Timer tick, asking Buildbucket for the build status
[22:56:31.666] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:29:0) after 1m0s
[22:57:31.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:29:0)
[22:57:31.741] Timer tick, asking Buildbucket for the build status
[22:57:32.032] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:32.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:30:0) after 1m0s
[22:58:32.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:30:0)
[22:58:32.123] Timer tick, asking Buildbucket for the build status
[22:58:32.352] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:32.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:31:0) after 1m0s
[22:59:32.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:31:0)
[22:59:32.598] Timer tick, asking Buildbucket for the build status
[22:59:32.698] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:32.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:32:0) after 1m0s
[23:00:32.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:32:0)
[23:00:32.776] Timer tick, asking Buildbucket for the build status
[23:00:33.260] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:33.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:33:0) after 1m0s
[23:01:33.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:33:0)
[23:01:33.316] Timer tick, asking Buildbucket for the build status
[23:01:33.708] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:33.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:34:0) after 1m0s
[23:02:33.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:34:0)
[23:02:33.788] Timer tick, asking Buildbucket for the build status
[23:02:33.902] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:33.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:35:0) after 1m0s
[23:03:33.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:35:0)
[23:03:33.980] Timer tick, asking Buildbucket for the build status
[23:03:34.074] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:34.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:36:0) after 1m0s
[23:04:34.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:36:0)
[23:04:34.083] Timer tick, asking Buildbucket for the build status
[23:04:34.152] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:34.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:37:0) after 1m0s
[23:05:34.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:37:0)
[23:05:34.245] Timer tick, asking Buildbucket for the build status
[23:05:34.387] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:34.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:38:0) after 1m0s
[23:06:34.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:38:0)
[23:06:34.426] Timer tick, asking Buildbucket for the build status
[23:06:34.549] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:34.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:39:0) after 1m0s
[23:07:34.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:39:0)
[23:07:34.581] Timer tick, asking Buildbucket for the build status
[23:07:34.708] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:34.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:40:0) after 1m0s
[23:08:34.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:40:0)
[23:08:34.767] Timer tick, asking Buildbucket for the build status
[23:08:34.889] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:34.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:41:0) after 1m0s
[23:09:34.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:41:0)
[23:09:34.951] Timer tick, asking Buildbucket for the build status
[23:09:35.034] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:35.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:42:0) after 1m0s
[23:10:35.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:42:0)
[23:10:35.106] Timer tick, asking Buildbucket for the build status
[23:10:35.212] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:35.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:43:0) after 1m0s
[23:11:35.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:43:0)
[23:11:35.277] Timer tick, asking Buildbucket for the build status
[23:11:35.641] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:44:0) after 1m0s
[23:12:35.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:44:0)
[23:12:35.668] Timer tick, asking Buildbucket for the build status
[23:12:35.786] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:35.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:45:0) after 1m0s
[23:13:35.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:45:0)
[23:13:35.845] Timer tick, asking Buildbucket for the build status
[23:13:35.948] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:35.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:46:0) after 1m0s
[23:14:36.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:46:0)
[23:14:36.001] Timer tick, asking Buildbucket for the build status
[23:14:36.122] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:36.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:47:0) after 1m0s
[23:15:36.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:47:0)
[23:15:36.228] Timer tick, asking Buildbucket for the build status
[23:15:36.445] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:36.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:48:0) after 1m0s
[23:16:36.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:48:0)
[23:16:36.500] Timer tick, asking Buildbucket for the build status
[23:16:36.784] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:36.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:49:0) after 1m0s
[23:17:36.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:49:0)
[23:17:36.829] Timer tick, asking Buildbucket for the build status
[23:17:37.226] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:37.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:50:0) after 1m0s
[23:18:37.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:50:0)
[23:18:37.287] Timer tick, asking Buildbucket for the build status
[23:18:37.461] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:37.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:51:0) after 1m0s
[23:19:37.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:51:0)
[23:19:37.544] Timer tick, asking Buildbucket for the build status
[23:19:37.929] Build 8854466826188559168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:37.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019896888214574384:52:0) after 1m0s
[23:20:30.308] Received PubSub notification, asking Buildbucket for the build status
[23:20:30.401] Build 8854466826188559168: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:20:30.401] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614122429642493",
"created_by": "project:chromium",
"created_ts": "1614119424600018",
"id": "8854466826188559168",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4\"}}",
"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\": \"3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4\", \"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-172-x07d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45675, \"got_angle_revision\": \"f19f319a59c83d9ccdce08a3b41024cfc997fd8d\", \"got_dawn_revision\": \"232f4d183ce8ab93909b30af814e320c0f0db57c\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4\", \"got_revision_cp\": \"refs/heads/master@{#856881}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"8bc6184274d97b9b57d5389e423f6f3f7c092918\", \"got_v8_revision_cp\": \"refs/heads/9.0.239@{#1}\", \"got_webrtc_revision\": \"d0844a80deaab28d7df8e5dff9f71e6ab6919025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33323}\", \"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\": \"3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4\", \"swarm_hashes_refs/heads/master(at){#856881}_without_patch\": {\"absl_hardening_tests\": \"14fdd353a0f5aac3256d188a681018794fd1820f\", \"accessibility_unittests\": \"d560cde138dcc37676f48196f4807a414d1a6d70\", \"angle_unittests\": \"13306ffdb69b6bf70c1ae87aaea10b86a7ff68b5\", \"app_list_unittests\": \"ae092fd7a2232cf35080b2ed117bbafd51230e2f\", \"app_shell_unittests\": \"92733ca3a0ee0ebd14ef4c4ba2764ea90872ddd8\", \"ash_unittests\": \"11f2598a7dc3d8411799e0abc0f2a863d4289f61\", \"aura_unittests\": \"590a8a042b38874ff67f4dbc3037d2a41cb9a01b\", \"base_unittests\": \"df60c03ebe91e9355eed34d4af26aa0f88d74d89\", \"base_util_unittests\": \"6f8b61b0f4ee43884295995d1fde719273278c69\", \"blink_common_unittests\": \"8190f5664b61e9d19e425e5fab67dc35b9258e35\", \"blink_fuzzer_unittests\": \"2dfd154573b79d2f2a2b2c9e00df4e5437c121d2\", \"blink_heap_unittests\": \"a840884fb3f1b8cb1181f66aa5f78961ab2de2a8\", \"blink_platform_unittests\": \"7a24c1bd19131461f035b745c079ecc87e2d9996\", \"blink_unittests\": \"b0730da9846e35f53a70c779b69e80f1709c4ea9\", \"boringssl_crypto_tests\": \"a041e2d1841edd944b8010f9609e45748165c868\", \"boringssl_ssl_tests\": \"8d7a9f58ed7a0b4021a7c65a7ce59086ec07d3e2\", \"browser_tests\": \"e19ad108b6cb8b32236ba8b8fe756bdad0959ba7\", \"capture_unittests\": \"d6cdb8abe2c53fde5b2a6f3c5a41d2aeb9a718d8\", \"cast_unittests\": \"8b41093077fba108d950d35eb95414f58ab061c5\", \"cc_unittests\": \"eb0a4d7c4cc76d6179f5e5e72a0d2a34585fe80c\", \"chrome_app_unittests\": \"0b97987cb18d033934868dda34a5036521304b95\", \"chromedriver_unittests\": \"127b75bdec7270f9b287edb917c1735e13f0f4ff\", \"chromeos_components_unittests\": \"67ada8ec37cf4fa5d0af366a6dab84f0b3c94c4a\", \"chromeos_unittests\": \"05f375729b88f3fbd0d50247659021f851fcff51\", \"components_browsertests\": \"88444d4c4006351e8bf2b43a1aa51bb7dedd2a6b\", \"components_unittests\": \"eb16a67a27aab100241c2b2ec3b4bd92fd53c60f\", \"compositor_unittests\": \"2479141ab90d2788469381066a04eaf701c199dd\", \"content_browsertests\": \"6c95db1baf1fecb01b49b8b44174d29921acf425\", \"content_unittests\": \"0c021727b3295b346fd15a2af324eb87d6e1dfdc\", \"crashpad_tests\": \"57880b9e05e9f4210356c2fe8425c77b6a7af301\", \"crypto_unittests\": \"1578e0c5c575a729c523655a3278151ed743ba2c\", \"dbus_unittests\": \"593cbb0c358b849061f71d5d3f802a341bc25feb\", \"device_unittests\": \"ff88a4fa970507c351bb1e4601a087f9fa832fa0\", \"display_unittests\": \"c5915a933117826f5156f2e967a68cdae3d6a8fd\", \"events_unittests\": \"66aa5117a9b177461e47eb2dd2bfb20ae7fa1daf\", \"exo_unittests\": \"2a8b783e5813fa6c17adb12a5ce84e2510550233\", \"extensions_browsertests\": \"237f7b4c9aa249da197867723b1e860ffc56d9d0\", \"extensions_unittests\": \"30579d6c4a71452812e0796a52190b65e4e6a327\", \"filesystem_service_unittests\": \"15c1a1791528e07487b4a8522a9892235f2206a1\", \"gcm_unit_tests\": \"69d9c5330c6511377cda41f77de1f14a1439f015\", \"gfx_unittests\": \"ba867737274d2d0b250ff18fe9506bc52a58d043\", \"gin_unittests\": \"36d888eef052cb065847e45137a5b6e767251a6b\", \"gl_unittests_ozone\": \"abab0b583c7716b8e7d4abc4f99ea9738342400d\", \"google_apis_unittests\": \"a5692475e3ab69db95c1a39f3c2dff5132231d5e\", \"gpu_unittests\": \"780bba59329b133c27fcd75fc858628da90130cd\", \"gwp_asan_unittests\": \"47fe900097d98628d7773ddcb4aa34c116bac20b\", \"interactive_ui_tests\": \"07d360754fdab36ac76dde42635705db2c49589b\", \"ipc_tests\": \"b843648d15f1b22bb44b91b3f971bef35728516c\", \"jingle_unittests\": \"91a1f5ec17e2ff18e2ff2b61d6d1a3834d9481b0\", \"keyboard_unittests\": \"d1241de2a8042ff4403ec555b104bc68614216df\", \"latency_unittests\": \"ba012e87d44dbf3be598a50e4ba205255bdc0140\", \"libjingle_xmpp_unittests\": \"498900204bf9d065d1033a0966b51f39eccd3360\", \"liburlpattern_unittests\": \"b192e27a9d85f57afd94121ab6cc9e2dbd2d1c92\", \"media_blink_unittests\": \"3db31e04c79340561a3167c734c74fce1c30079e\", \"media_unittests\": \"2712955da80256a29ad724765074f4eae8699663\", \"message_center_unittests\": \"6207677ade1aa0a540677d5636c71b48808a7940\", \"midi_unittests\": \"82a5e74837207a1f8fb6f7e4d5e2f34a7ee56293\", \"mojo_core_unittests\": \"153379a248ff5a4d212d3e841ebb893a3cdeed3b\", \"mojo_unittests\": \"87d24b1d1d2ac40d7828491c77a26b1754345d89\", \"nacl_helper_nonsfi_unittests\": \"322f42ac61e8c7bec0e6e64702359ab17782e73c\", \"nacl_loader_unittests\": \"7d691031f2eb07a46f4c3a0fbe60eaaaf895f88a\", \"native_theme_unittests\": \"b94386af9f551353a7ef79ef86c5e79a8d6c3da1\", \"net_unittests\": \"67f9715036f239500a7b73945e8202c52e78829f\", \"ozone_gl_unittests\": \"ab836c75322251b905935a6e75e73a267910cbfa\", \"ozone_unittests\": \"4a04dc2ed490b41c6d326d9d1569ace8c0dd8e48\", \"ozone_x11_unittests\": \"ef3e13239f03a0730a0b701e53f144f02710a549\", \"pdf_unittests\": \"ccf086d5890aa004fa2655124509a92f1b196ca2\", \"perfetto_unittests\": \"9afd000696efef036a6a2f50afe21fda03af1a56\", \"ppapi_unittests\": \"9dab6559b25bfa5c0c92321f6fc80ecb04565a8b\", \"printing_unittests\": \"f2b744b7b5d00d0a9875a596442891ca126277aa\", \"remoting_unittests\": \"aad7199ea066d78adcc11db51b365bf54fbf0c74\", \"sandbox_linux_unittests\": \"fce57e6c1eb508095e156325f19df05ff1755724\", \"service_manager_unittests\": \"3ab9ff00f188a5da06f2bf714702bf05f3294616\", \"services_unittests\": \"2aabfbef77106dee62a73473f314bfc30961c0d5\", \"shell_dialogs_unittests\": \"542565747d57baa860f7bfe8351c6cab740139ea\", \"shell_encryption_unittests\": \"e9aca797077ffb202a9875d4878fd2bc963cc257\", \"skia_unittests\": \"9576af27f842f353d0a52baff9e75bbda424b6d2\", \"snapshot_unittests\": \"0c1259c1234c14c36a91e6c011c21f7af01860e5\", \"sql_unittests\": \"a94f388c28e5a3b78683c9cbe5ca9ff522c70ed7\", \"storage_unittests\": \"b6bbc8e75e0b574ca0348192a59c7a3c55dc1f18\", \"sync_integration_tests\": \"d69a440c540d425de64c64b4506d783ae022969e\", \"traffic_annotation_auditor_unittests\": \"a05179b9017337e736a5537e91406a2363b1273e\", \"ui_base_unittests\": \"b78c6314d08a0e48b8265e91364b56c08cdcd863\", \"ui_chromeos_unittests\": \"bde6b197a9676662ca3f76385e7ee12fecf8c32d\", \"ui_touch_selection_unittests\": \"4887208c6e1f346fedf82260cd6539171b7f9d98\", \"unit_tests\": \"d5233dcb6d53a85cff04ae899a9be7bb1804d221\", \"url_unittests\": \"f1c9ccb33c822995257e10b00ac2d58a9e010368\", \"usage_time_limit_unittests\": \"2ef085db5bce05a51df80b1db867f50f8cbce4a8\", \"views_unittests\": \"73e290eb8d1a7bc63b06b7756fcdb3033289ea58\", \"viz_unittests\": \"350ae57ba8655de8899a3d844fe234f1d26adef7\", \"wayland_client_perftests\": \"33ad72c117461be1174f6bcdf70fa552b92dcfa3\", \"wm_unittests\": \"58955ef01f3fb389cc9f4ae2a1c27bdb4d693e81\", \"wtf_unittests\": \"6d68898712ac771b7ab6b56aab2d080e93093538\", \"zlib_unittests\": \"a42ac3e3d5d0d19c295beee3fd89c4e0d49ad59f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_541cf43b1bca5745fae9eb808cc6f212921580c436c428e330e275f831e0e73a_v2\", \"builder_800f6f487d95d787b5e050c93b44c7c7276a85aefb5f9344834f1f03ffd0e322_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_be71ec2e45ff41f29ecdc3611cfb7c276cc0ff3138424d653aa2b7cfb51218d3_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-172-x07d\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614119430188235",
"status": "COMPLETED",
"status_changed_ts": "1614122429906058",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45675",
"builder:linux-chromeos-rel",
"buildset:commit/git/3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3b8558b73f9c3cedad1cab0a9c8de0c47906a5b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019896888214574384",
"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/8854466826188559168/+/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:51e9d55f9313e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1614122429910787",
"url": "https://ci.chromium.org/b/8854466826188559168",
"utcnow_ts": "1614122430385166"
}
}
[23:20:30.402] Invocation finished in 50m7.117219218s with status SUCCEEDED