[20:30:05.728] New invocation is queued and will start shortly
[20:30:07.346] Starting the invocation (attempt 1)
[20:30:07.384] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:07.384] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:07.384] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018454904924386768",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"973f1c3e454d812833243062341c8db2e8109e7c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018454904924386768",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/973f1c3e454d812833243062341c8db2e8109e7c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/973f1c3e454d812833243062341c8db2e8109e7c",
"gitiles_ref:refs/heads/master"
]
}
[20:30:09.288] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615494607710588",
"id": "8853024842184008992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"973f1c3e454d812833243062341c8db2e8109e7c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615494608993785",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181309",
"builder:Linux Builder (dbg)",
"buildset:commit/git/973f1c3e454d812833243062341c8db2e8109e7c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/973f1c3e454d812833243062341c8db2e8109e7c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018454904924386768",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853024842184008992/+/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": "1615494608993879",
"url": "https://ci.chromium.org/b/8853024842184008992",
"utcnow_ts": "1615494609271218"
}
}
[20:30:09.288] Task URL: https://ci.chromium.org/b/8853024842184008992
[20:30:09.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:2:0) after 1m0s
[20:30:10.729] Received PubSub notification, asking Buildbucket for the build status
[20:30:10.875] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:09.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:2:0)
[20:31:09.335] Timer tick, asking Buildbucket for the build status
[20:31:09.397] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:09.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:4:0) after 1m0s
[20:32:09.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:4:0)
[20:32:09.437] Timer tick, asking Buildbucket for the build status
[20:32:09.523] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:09.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:5:0) after 1m0s
[20:33:09.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:5:0)
[20:33:09.543] Timer tick, asking Buildbucket for the build status
[20:33:09.618] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:09.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:6:0) after 1m0s
[20:34:09.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:6:0)
[20:34:09.589] Timer tick, asking Buildbucket for the build status
[20:34:09.671] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:09.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:7:0) after 1m0s
[20:35:09.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:7:0)
[20:35:09.734] Timer tick, asking Buildbucket for the build status
[20:35:09.896] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:09.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:8:0) after 1m0s
[20:36:09.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:8:0)
[20:36:09.914] Timer tick, asking Buildbucket for the build status
[20:36:10.092] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:10.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:9:0) after 1m0s
[20:37:10.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:9:0)
[20:37:10.126] Timer tick, asking Buildbucket for the build status
[20:37:10.213] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:10.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:10:0) after 1m0s
[20:38:10.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:10:0)
[20:38:10.294] Timer tick, asking Buildbucket for the build status
[20:38:10.389] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:10.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:11:0) after 1m0s
[20:39:10.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:11:0)
[20:39:10.486] Timer tick, asking Buildbucket for the build status
[20:39:10.645] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:10.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:12:0) after 1m0s
[20:40:10.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:12:0)
[20:40:10.645] Timer tick, asking Buildbucket for the build status
[20:40:10.737] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:10.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:13:0) after 1m0s
[20:41:10.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:13:0)
[20:41:10.795] Timer tick, asking Buildbucket for the build status
[20:41:10.866] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:10.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:14:0) after 1m0s
[20:42:10.925] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:14:0)
[20:42:10.925] Timer tick, asking Buildbucket for the build status
[20:42:11.321] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:11.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:15:0) after 1m0s
[20:43:11.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:15:0)
[20:43:11.341] Timer tick, asking Buildbucket for the build status
[20:43:11.402] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:11.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:16:0) after 1m0s
[20:44:11.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:16:0)
[20:44:11.469] Timer tick, asking Buildbucket for the build status
[20:44:11.654] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:11.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:17:0) after 1m0s
[20:45:11.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:17:0)
[20:45:11.759] Timer tick, asking Buildbucket for the build status
[20:45:12.263] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:18:0) after 1m0s
[20:46:12.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:18:0)
[20:46:12.290] Timer tick, asking Buildbucket for the build status
[20:46:12.359] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:12.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:19:0) after 1m0s
[20:47:12.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:19:0)
[20:47:12.379] Timer tick, asking Buildbucket for the build status
[20:47:12.859] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:12.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:20:0) after 1m0s
[20:48:12.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:20:0)
[20:48:12.871] Timer tick, asking Buildbucket for the build status
[20:48:12.953] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:12.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:21:0) after 1m0s
[20:49:13.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:21:0)
[20:49:13.056] Timer tick, asking Buildbucket for the build status
[20:49:13.143] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:13.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:22:0) after 1m0s
[20:50:13.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:22:0)
[20:50:13.170] Timer tick, asking Buildbucket for the build status
[20:50:13.295] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:13.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:23:0) after 1m0s
[20:51:13.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:23:0)
[20:51:13.354] Timer tick, asking Buildbucket for the build status
[20:51:13.459] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:13.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:24:0) after 1m0s
[20:52:13.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:24:0)
[20:52:13.490] Timer tick, asking Buildbucket for the build status
[20:52:13.566] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:13.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:25:0) after 1m0s
[20:53:13.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:25:0)
[20:53:13.607] Timer tick, asking Buildbucket for the build status
[20:53:13.680] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:13.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:26:0) after 1m0s
[20:54:13.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:26:0)
[20:54:13.702] Timer tick, asking Buildbucket for the build status
[20:54:13.807] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:13.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:27:0) after 1m0s
[20:55:13.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:27:0)
[20:55:13.829] Timer tick, asking Buildbucket for the build status
[20:55:13.914] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:13.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:28:0) after 1m0s
[20:56:13.988] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:28:0)
[20:56:13.988] Timer tick, asking Buildbucket for the build status
[20:56:14.848] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:14.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:29:0) after 1m0s
[20:57:14.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:29:0)
[20:57:14.847] Timer tick, asking Buildbucket for the build status
[20:57:15.333] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:15.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:30:0) after 1m0s
[20:58:15.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:30:0)
[20:58:15.412] Timer tick, asking Buildbucket for the build status
[20:58:15.579] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:15.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:31:0) after 1m0s
[20:59:15.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:31:0)
[20:59:15.703] Timer tick, asking Buildbucket for the build status
[20:59:15.769] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:15.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:32:0) after 1m0s
[21:00:15.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:32:0)
[21:00:15.864] Timer tick, asking Buildbucket for the build status
[21:00:16.012] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:16.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:33:0) after 1m0s
[21:01:16.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:33:0)
[21:01:16.142] Timer tick, asking Buildbucket for the build status
[21:01:16.231] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:16.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:34:0) after 1m0s
[21:02:16.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:34:0)
[21:02:16.517] Timer tick, asking Buildbucket for the build status
[21:02:16.596] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:16.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:35:0) after 1m0s
[21:03:16.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:35:0)
[21:03:16.791] Timer tick, asking Buildbucket for the build status
[21:03:16.894] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:16.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:36:0) after 1m0s
[21:04:17.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:36:0)
[21:04:17.101] Timer tick, asking Buildbucket for the build status
[21:04:17.170] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:17.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:37:0) after 1m0s
[21:05:17.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:37:0)
[21:05:17.389] Timer tick, asking Buildbucket for the build status
[21:05:17.470] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:17.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:38:0) after 1m0s
[21:06:17.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:38:0)
[21:06:17.557] Timer tick, asking Buildbucket for the build status
[21:06:17.628] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:17.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:39:0) after 1m0s
[21:07:17.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:39:0)
[21:07:17.759] Timer tick, asking Buildbucket for the build status
[21:07:17.907] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:17.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:40:0) after 1m0s
[21:08:17.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:40:0)
[21:08:17.991] Timer tick, asking Buildbucket for the build status
[21:08:18.070] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:18.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:41:0) after 1m0s
[21:09:18.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:41:0)
[21:09:18.210] Timer tick, asking Buildbucket for the build status
[21:09:18.274] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:18.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:42:0) after 1m0s
[21:10:18.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:42:0)
[21:10:18.369] Timer tick, asking Buildbucket for the build status
[21:10:18.589] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:18.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:43:0) after 1m0s
[21:11:18.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:43:0)
[21:11:18.649] Timer tick, asking Buildbucket for the build status
[21:11:18.849] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:18.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:44:0) after 1m0s
[21:12:18.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:44:0)
[21:12:18.967] Timer tick, asking Buildbucket for the build status
[21:12:19.038] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:19.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:45:0) after 1m0s
[21:13:19.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:45:0)
[21:13:19.157] Timer tick, asking Buildbucket for the build status
[21:13:19.284] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:19.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:46:0) after 1m0s
[21:14:19.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:46:0)
[21:14:19.287] Timer tick, asking Buildbucket for the build status
[21:14:19.359] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:19.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:47:0) after 1m0s
[21:15:19.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:47:0)
[21:15:19.386] Timer tick, asking Buildbucket for the build status
[21:15:19.470] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:19.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:48:0) after 1m0s
[21:16:19.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:48:0)
[21:16:19.492] Timer tick, asking Buildbucket for the build status
[21:16:19.567] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:19.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:49:0) after 1m0s
[21:17:19.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:49:0)
[21:17:19.612] Timer tick, asking Buildbucket for the build status
[21:17:19.703] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:19.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:50:0) after 1m0s
[21:18:19.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:50:0)
[21:18:19.691] Timer tick, asking Buildbucket for the build status
[21:18:20.006] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:20.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:51:0) after 1m0s
[21:19:20.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:51:0)
[21:19:20.019] Timer tick, asking Buildbucket for the build status
[21:19:20.099] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:20.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:52:0) after 1m0s
[21:20:20.230] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:52:0)
[21:20:20.230] Timer tick, asking Buildbucket for the build status
[21:20:20.312] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:20.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:53:0) after 1m0s
[21:21:20.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:53:0)
[21:21:20.374] Timer tick, asking Buildbucket for the build status
[21:21:21.387] Build 8853024842184008992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:21.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018454904924386768:54:0) after 1m0s
[21:22:19.182] Received PubSub notification, asking Buildbucket for the build status
[21:22:19.346] Build 8853024842184008992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:22:19.346] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615497738141432",
"created_by": "project:chromium",
"created_ts": "1615494607710588",
"id": "8853024842184008992",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"973f1c3e454d812833243062341c8db2e8109e7c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"973f1c3e454d812833243062341c8db2e8109e7c\", \"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-62-fu69\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181309, \"got_angle_revision\": \"6f74a12b396bb8039f1f2446e62dbe07ec0886a5\", \"got_dawn_revision\": \"9f6bc4e3a95a5ae4e009d76812f752340d1d6181\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"973f1c3e454d812833243062341c8db2e8109e7c\", \"got_revision_cp\": \"refs/heads/master@{#862108}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"08ad3359339358d65587e274741c75e3c140c91f\", \"got_v8_revision_cp\": \"refs/heads/9.1.102@{#1}\", \"got_webrtc_revision\": \"14a626af56675c9d95f9fb207d53366a53a95fbd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33409}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"973f1c3e454d812833243062341c8db2e8109e7c\", \"swarm_hashes_refs/heads/master(at){#862108}_without_patch\": {\"absl_hardening_tests\": \"34ddbcff8aad0d40cf8e1d04a36fa9a67cf76438\", \"accessibility_unittests\": \"27872053a424dc259d1ad55a7b4fae0e95ccd670\", \"angle_unittests\": \"da5e41d60f6485a4f3290ea91da8154dbb70f756\", \"app_shell_unittests\": \"2c1be918cc3bb1d5561f6c615365205bda35ffe9\", \"aura_unittests\": \"ea17fd5555b01a7c5b322196a6698b3f5462d73a\", \"base_unittests\": \"29b409b15e08e67842b8a233a8935da638882f56\", \"base_util_unittests\": \"7ff6b230b2c630ae99c255a1f2388218944a1e48\", \"blink_common_unittests\": \"6d75eee977e39e0623f1db22657195e580ce5bfa\", \"blink_fuzzer_unittests\": \"2fa62b9ffdeb71c883f7edd4929d7910f72ab05e\", \"blink_heap_unittests\": \"56dac60433804f11247331f04f9ccf68b2da4510\", \"blink_platform_unittests\": \"7bf5d3ebffb872f6acef53dbfb580c9b7100bb6a\", \"blink_python_tests\": \"4960d3cf911583247272c94495a9193c6970766c\", \"blink_unittests\": \"4937d3029b5d153dc04822fa075f45043ff52cd6\", \"blink_web_tests\": \"0c21395336baadd59c6788e4622b9944e53c1ac1\", \"boringssl_crypto_tests\": \"45e4395e691465a504adee618b9b5789b77b088a\", \"boringssl_ssl_tests\": \"0c2a93b5ad98430ed4832470f8e366c76a302478\", \"browser_tests\": \"dd0178cba988612ae820a36495d3dbe045a2ed28\", \"capture_unittests\": \"cd79d8cdeb57cac5f0d8a93ce6dcf3e81e24bbe2\", \"cast_unittests\": \"ab6c3a741a39e19a93aa3c169066e0310271b424\", \"cc_unittests\": \"a8dc3ffb47d5c42320da7a597eaf6c20ee43d1b1\", \"chrome_app_unittests\": \"66dd49b00212af0612749c73541848d7d37caac3\", \"chromedriver_unittests\": \"d63a8bf058a25e7a1dc9a5f2c702d62c9c5ed4dc\", \"color_unittests\": \"857913f4bfc2bd08605a2119276512ad0f4989b5\", \"components_browsertests\": \"89486d7520a9b89cde7cdfaf0d556d6f2e66200c\", \"components_unittests\": \"dec9e0af5793676d9499277cea38609ea6335451\", \"compositor_unittests\": \"1505574948b563bf3d00fb8ed19bf0ff1d723e47\", \"content_browsertests\": \"1a8d60acb5816815270816fc45a78bb5ea3d1cdd\", \"content_shell_crash_test\": \"360cbc17b7e8c76763614d69e004208d890e43e7\", \"content_unittests\": \"90e2c77372bd943c7e7ff437a90f8470a58d68f2\", \"crashpad_tests\": \"4d67f2dec54875f50c49e185da026496eaf783b3\", \"cronet_tests\": \"e3b4fcb0afdde04ef1830ffac3efd1bb4fca2c49\", \"cronet_unittests\": \"6b0f2e91f0096027ed02794286a514ba74cddf4a\", \"crypto_unittests\": \"3ecf3a8598fc99114dfac798530adfecbf5c7039\", \"dbus_unittests\": \"4400a76dbb6aaf836c64f69115c5f0f83cd81ee7\", \"device_unittests\": \"10b12371983986d034b61a7594be9f631820f7bc\", \"display_unittests\": \"acd9576957597a385518add8e60840edc8c75f0d\", \"events_unittests\": \"99b5325c32dc25b858439402d13906c4bc6054ed\", \"extensions_browsertests\": \"be1b682af0e554a3f22c634ab78e776019ce5599\", \"extensions_unittests\": \"0472e2cd1e74b896f5b41a5da5a40dedf8ec7b7d\", \"filesystem_service_unittests\": \"c8264bd1f96b1af4c914dfcb6499be5e5652399a\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"062aab119fc258e3937ca43f541a5f467b64a20a\", \"gfx_unittests\": \"96faa8a391e34018ff0c4369158b7b44220ef1a9\", \"gin_unittests\": \"e5f17e45f4251583713515d450b1c81b7d7d5482\", \"google_apis_unittests\": \"72458470e25000266cdb5e54ee9709bdbfab815b\", \"gpu_unittests\": \"0dd79bc2d9b27d1fd9a9a3100d198a9355ac6b91\", \"grit_python_unittests\": \"34dc6f3cc2d88a5fac848f4742c34f024387cdb5\", \"gwp_asan_unittests\": \"38d8eb8e0941c5039a7783b59f36233212412673\", \"headless_browsertests\": \"a118466571e70f44af46981e3908b1edc2c09609\", \"headless_unittests\": \"c39382b752701aa972752db05ed3732ea47ea57b\", \"interactive_ui_tests\": \"637034c2f720261889697371df34831a2c56c709\", \"ipc_tests\": \"55cb022aded52b823e27c2bde99097d266ff5fe3\", \"jingle_unittests\": \"a124cb96e7bf5204c373c14cc018e9d23a0e0da5\", \"latency_unittests\": \"6cd0bf014b19d254c46c720bbddc707b5932ebef\", \"libjingle_xmpp_unittests\": \"0466c732dc6789e781c493fbaf705f8863762f13\", \"liburlpattern_unittests\": \"5c8262c2ce6209eb921fb535b951f395af7496a5\", \"media_blink_unittests\": \"5374bb18d46ad5be21d7a446bcb428eeeff4af4d\", \"media_unittests\": \"e6ddb8551793e55e5923c9f746652ad12252bf83\", \"message_center_unittests\": \"0131cd48f608c916eedb36d3cc3f11098b7abbb9\", \"metrics_python_tests\": \"5149f749410d0199fefd18585931b9d26a98d8b9\", \"midi_unittests\": \"d0fa832805da448d1b3f9ca7a3a05ceb58170d49\", \"mojo_core_unittests\": \"0b9584379533d424253e8228f0a80de5dcc5bbdd\", \"mojo_unittests\": \"56051f37c02149d2edab67155debd9ff72344ea4\", \"nacl_helper_nonsfi_unittests\": \"29e08943562fe468ea7c4daae56cd88dc615ea9e\", \"nacl_loader_unittests\": \"98c83a63fa9b9db691152a604664293676fe6d43\", \"native_theme_unittests\": \"2a661cb6f699aaf79e10718a650b3bbf9068347c\", \"net_unittests\": \"818b0a6ee7fc9d253f82be16fcc688c749132bc8\", \"openscreen_unittests\": \"8838ea9305f06ed846a75d7c42d12f37ce7da079\", \"pdf_unittests\": \"f676beff7f2d8edc71b21c4ab283b90002880f92\", \"perfetto_unittests\": \"f092b8c1f210a3656ccc3c76f0258925c83ffb50\", \"ppapi_unittests\": \"5acb55eb1f00a6103192b8296b09a4e99d42762d\", \"printing_unittests\": \"6df92c4ead179a9f36eb3c8a319b5137f7eef7ef\", \"remoting_unittests\": \"6aa1cc0fc6cbbed476c7609a6f177c2e802fdb24\", \"sandbox_linux_unittests\": \"3973179ba16c5c9a9b464624ffffcf343167d965\", \"service_manager_unittests\": \"060bd92b6250934ad241d719817f23f370c60e91\", \"services_unittests\": \"512e0e14677bbded8d438dbf8dcce5878ed92cfb\", \"shell_dialogs_unittests\": \"a8f9a54939d3961fbe00aea5e04c8cddb3670324\", \"skia_unittests\": \"c15585e694d2eb1fde97b738722216c288779299\", \"snapshot_unittests\": \"721094e02b0353b0cfd621f03a075d8ac219f147\", \"sql_unittests\": \"08ec2f92ddaf161d26018b80f83e5a2a0004f398\", \"storage_unittests\": \"74dbad7933bf74a7ab7870ad1cf27b6c394c017c\", \"sync_integration_tests\": \"fbb3f0df045dab229e63905d5c8657e01a3ed6a9\", \"telemetry_gpu_unittests\": \"fcbc15c2592d28d445ff6f4ecbc9da83403841f8\", \"telemetry_perf_unittests\": \"c569d24c8993afea242ef6dcab99c9fb0ca67f51\", \"telemetry_unittests\": \"41ea3dd18be35187f59869124c21ea6432a7114e\", \"traffic_annotation_auditor_unittests\": \"9d787b41a0891ee4010d826f29c17c138629f62c\", \"ui_base_unittests\": \"492a32ba59d658d8dee5d5275533ef8ba0d70361\", \"ui_touch_selection_unittests\": \"82f19ab2bab898c1d0e1700670fe6c971b525dfa\", \"unit_tests\": \"69311b51edb9670950f0590e29c5cbb8ea0a0165\", \"url_unittests\": \"fd55f42ac053ffb181bf492cb72c8cca27abcca1\", \"views_perftests\": \"3eab581fd04fa14c861589028d781f7e53a2db6a\", \"views_unittests\": \"2786fd6cfbf8aec25640975303b1a6204fee1e4c\", \"viz_unittests\": \"c3301aada45e0857d89777e26adc1cfc78010f6c\", \"vr_common_unittests\": \"a31a74eba719871c30bc957353bf90ded3e60db1\", \"vr_pixeltests\": \"8ca3773473464ffa3bb0ae56c2b25935ebda8cbb\", \"webdriver_wpt_tests\": \"9a226916d4154043f83d60cd7b55de27c4b4c46d\", \"weblayer_browsertests\": \"e6468873eb618a31b566a569b268294a2262af4e\", \"weblayer_unittests\": \"15ec747bdf07fea09455c7674338e24c44f772a0\", \"wm_unittests\": \"a35f62a5641b241db0b886f50f6d2662f0ad77a7\", \"wtf_unittests\": \"a1412501c493a90d993c37152e4e27e1cf1b8ca1\", \"x11_unittests\": \"1d340f7fd629c6e5b2940a7242837eca5d2761ec\", \"xr_browser_tests\": \"adac01a576e6254141b479a28f513583fba6ab0c\", \"zlib_unittests\": \"55ef13c9d04ddd4284c8c579e1077bb181ca2d7a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_9f247f4686c5cf47ea762220cc037b3e853f43c1442c10d387faa806e919f9a9_v2\", \"builder_de67dcb387b95c18ea83e54ea320474d260d319089536d63e3279fdbb975ff72_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-62-fu69\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615494609873919",
"status": "COMPLETED",
"status_changed_ts": "1615497738648395",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181309",
"builder:Linux Builder (dbg)",
"buildset:commit/git/973f1c3e454d812833243062341c8db2e8109e7c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/973f1c3e454d812833243062341c8db2e8109e7c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018454904924386768",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853024842184008992/+/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:523bcd022a3b6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1615497738658106",
"url": "https://ci.chromium.org/b/8853024842184008992",
"utcnow_ts": "1615497739338044"
}
}
[21:22:19.346] Invocation finished in 52m13.633296783s with status SUCCEEDED