[00:45:14.482] New invocation is queued and will start shortly
[00:45:15.566] Starting the invocation (attempt 1)
[00:45:15.608] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:45:15.609] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:45:15.609] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051506745269815536",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051506745269815536",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2",
"gitiles_ref:refs/heads/master"
]
}
[00:45:16.249] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583973915697936",
"id": "8886076683332489952",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583973916119691",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169631",
"builder:Linux Builder (dbg)",
"buildset:commit/git/aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051506745269815536",
"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/8886076683332489952/+/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": "1583973916119824",
"url": "https://ci.chromium.org/b/8886076683332489952",
"utcnow_ts": "1583973916240909"
}
}
[00:45:16.249] Task URL: https://ci.chromium.org/b/8886076683332489952
[00:45:16.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:2:0) after 1m0s
[00:46:16.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:2:0)
[00:46:16.280] Timer tick, asking Buildbucket for the build status
[00:46:16.398] Build 8886076683332489952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:16.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:3:0) after 1m0s
[00:47:16.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:3:0)
[00:47:16.433] Timer tick, asking Buildbucket for the build status
[00:47:16.545] Build 8886076683332489952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:16.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:4:0) after 1m0s
[00:48:16.662] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:4:0)
[00:48:16.662] Timer tick, asking Buildbucket for the build status
[00:48:16.928] Build 8886076683332489952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:16.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:5:0) after 1m0s
[00:49:16.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:5:0)
[00:49:16.958] Timer tick, asking Buildbucket for the build status
[00:49:17.073] Build 8886076683332489952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:17.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:6:0) after 1m0s
[00:50:13.238] Received PubSub notification, asking Buildbucket for the build status
[00:50:13.372] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:17.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:6:0)
[00:50:17.117] Timer tick, asking Buildbucket for the build status
[00:50:17.215] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:8:0) after 1m0s
[00:51:17.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:8:0)
[00:51:17.207] Timer tick, asking Buildbucket for the build status
[00:51:17.388] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:17.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:9:0) after 1m0s
[00:52:17.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:9:0)
[00:52:17.385] Timer tick, asking Buildbucket for the build status
[00:52:17.513] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:17.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:10:0) after 1m0s
[00:53:17.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:10:0)
[00:53:17.620] Timer tick, asking Buildbucket for the build status
[00:53:17.749] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:17.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:11:0) after 1m0s
[00:54:17.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:11:0)
[00:54:17.768] Timer tick, asking Buildbucket for the build status
[00:54:17.855] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:17.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:12:0) after 1m0s
[00:55:17.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:12:0)
[00:55:17.909] Timer tick, asking Buildbucket for the build status
[00:55:18.183] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:18.183] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:13:0) after 1m0s
[00:56:18.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:13:0)
[00:56:18.325] Timer tick, asking Buildbucket for the build status
[00:56:18.493] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:18.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:14:0) after 1m0s
[00:57:18.540] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:14:0)
[00:57:18.540] Timer tick, asking Buildbucket for the build status
[00:57:18.826] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:18.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:15:0) after 1m0s
[00:58:18.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:15:0)
[00:58:18.846] Timer tick, asking Buildbucket for the build status
[00:58:18.979] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:18.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:16:0) after 1m0s
[00:59:19.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:16:0)
[00:59:19.002] Timer tick, asking Buildbucket for the build status
[00:59:19.120] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:19.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:17:0) after 1m0s
[01:00:19.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:17:0)
[01:00:19.173] Timer tick, asking Buildbucket for the build status
[01:00:19.365] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:19.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:18:0) after 1m0s
[01:01:19.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:18:0)
[01:01:19.408] Timer tick, asking Buildbucket for the build status
[01:01:19.523] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:19.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:19:0) after 1m0s
[01:02:19.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:19:0)
[01:02:19.504] Timer tick, asking Buildbucket for the build status
[01:02:19.573] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:19.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:20:0) after 1m0s
[01:03:19.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:20:0)
[01:03:19.627] Timer tick, asking Buildbucket for the build status
[01:03:19.761] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:19.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:21:0) after 1m0s
[01:04:19.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:21:0)
[01:04:19.872] Timer tick, asking Buildbucket for the build status
[01:04:20.068] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:20.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:22:0) after 1m0s
[01:05:20.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:22:0)
[01:05:20.098] Timer tick, asking Buildbucket for the build status
[01:05:20.288] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:20.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:23:0) after 1m0s
[01:06:20.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:23:0)
[01:06:20.450] Timer tick, asking Buildbucket for the build status
[01:06:20.573] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:20.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:24:0) after 1m0s
[01:07:20.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:24:0)
[01:07:20.826] Timer tick, asking Buildbucket for the build status
[01:07:20.944] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:20.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:25:0) after 1m0s
[01:08:20.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:25:0)
[01:08:20.962] Timer tick, asking Buildbucket for the build status
[01:08:21.090] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:21.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:26:0) after 1m0s
[01:09:21.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:26:0)
[01:09:21.115] Timer tick, asking Buildbucket for the build status
[01:09:21.883] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:21.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:27:0) after 1m0s
[01:10:22.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:27:0)
[01:10:22.042] Timer tick, asking Buildbucket for the build status
[01:10:22.267] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:22.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:28:0) after 1m0s
[01:11:22.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:28:0)
[01:11:22.272] Timer tick, asking Buildbucket for the build status
[01:11:22.393] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:22.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:29:0) after 1m0s
[01:12:22.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:29:0)
[01:12:22.459] Timer tick, asking Buildbucket for the build status
[01:12:22.518] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:22.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:30:0) after 1m0s
[01:13:22.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:30:0)
[01:13:22.636] Timer tick, asking Buildbucket for the build status
[01:13:22.725] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:22.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:31:0) after 1m0s
[01:14:22.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:31:0)
[01:14:22.716] Timer tick, asking Buildbucket for the build status
[01:14:22.851] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:22.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:32:0) after 1m0s
[01:15:22.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:32:0)
[01:15:22.856] Timer tick, asking Buildbucket for the build status
[01:15:22.939] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:22.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:33:0) after 1m0s
[01:16:23.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:33:0)
[01:16:23.047] Timer tick, asking Buildbucket for the build status
[01:16:23.370] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:23.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:34:0) after 1m0s
[01:17:23.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:34:0)
[01:17:23.403] Timer tick, asking Buildbucket for the build status
[01:17:23.532] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:23.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:35:0) after 1m0s
[01:18:23.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:35:0)
[01:18:23.552] Timer tick, asking Buildbucket for the build status
[01:18:23.806] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:23.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:36:0) after 1m0s
[01:19:23.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:36:0)
[01:19:23.857] Timer tick, asking Buildbucket for the build status
[01:19:24.015] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:24.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:37:0) after 1m0s
[01:20:24.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:37:0)
[01:20:24.039] Timer tick, asking Buildbucket for the build status
[01:20:24.189] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:24.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:38:0) after 1m0s
[01:21:24.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:38:0)
[01:21:24.242] Timer tick, asking Buildbucket for the build status
[01:21:24.446] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:24.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:39:0) after 1m0s
[01:22:24.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:39:0)
[01:22:24.517] Timer tick, asking Buildbucket for the build status
[01:22:24.931] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:24.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:40:0) after 1m0s
[01:23:24.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:40:0)
[01:23:24.971] Timer tick, asking Buildbucket for the build status
[01:23:25.128] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:25.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:41:0) after 1m0s
[01:24:25.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:41:0)
[01:24:25.179] Timer tick, asking Buildbucket for the build status
[01:24:25.302] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:25.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:42:0) after 1m0s
[01:25:25.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:42:0)
[01:25:25.322] Timer tick, asking Buildbucket for the build status
[01:25:25.463] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:25.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:43:0) after 1m0s
[01:26:25.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:43:0)
[01:26:25.522] Timer tick, asking Buildbucket for the build status
[01:26:25.611] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:25.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:44:0) after 1m0s
[01:27:25.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:44:0)
[01:27:25.716] Timer tick, asking Buildbucket for the build status
[01:27:25.898] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:25.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:45:0) after 1m0s
[01:28:25.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:45:0)
[01:28:25.875] Timer tick, asking Buildbucket for the build status
[01:28:26.007] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:26.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:46:0) after 1m0s
[01:29:26.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:46:0)
[01:29:26.563] Timer tick, asking Buildbucket for the build status
[01:29:26.792] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:26.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:47:0) after 1m0s
[01:30:26.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:47:0)
[01:30:26.825] Timer tick, asking Buildbucket for the build status
[01:30:26.980] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:26.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:48:0) after 1m0s
[01:31:27.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:48:0)
[01:31:27.071] Timer tick, asking Buildbucket for the build status
[01:31:27.234] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:27.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:49:0) after 1m0s
[01:32:27.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:49:0)
[01:32:27.407] Timer tick, asking Buildbucket for the build status
[01:32:27.570] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:27.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:50:0) after 1m0s
[01:33:27.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:50:0)
[01:33:27.655] Timer tick, asking Buildbucket for the build status
[01:33:28.093] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:28.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:51:0) after 1m0s
[01:34:28.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:51:0)
[01:34:28.159] Timer tick, asking Buildbucket for the build status
[01:34:28.263] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:28.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:52:0) after 1m0s
[01:35:28.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:52:0)
[01:35:28.243] Timer tick, asking Buildbucket for the build status
[01:35:28.370] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:28.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:53:0) after 1m0s
[01:36:28.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:53:0)
[01:36:28.399] Timer tick, asking Buildbucket for the build status
[01:36:28.605] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:28.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:54:0) after 1m0s
[01:37:28.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:54:0)
[01:37:28.711] Timer tick, asking Buildbucket for the build status
[01:37:28.869] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:28.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:55:0) after 1m0s
[01:38:28.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:55:0)
[01:38:28.948] Timer tick, asking Buildbucket for the build status
[01:38:29.046] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:29.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:56:0) after 1m0s
[01:39:29.230] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:56:0)
[01:39:29.230] Timer tick, asking Buildbucket for the build status
[01:39:29.573] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:29.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:57:0) after 1m0s
[01:40:29.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:57:0)
[01:40:29.659] Timer tick, asking Buildbucket for the build status
[01:40:29.818] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:29.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:58:0) after 1m0s
[01:41:29.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:58:0)
[01:41:29.910] Timer tick, asking Buildbucket for the build status
[01:41:30.228] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:30.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:59:0) after 1m0s
[01:42:30.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:59:0)
[01:42:30.379] Timer tick, asking Buildbucket for the build status
[01:42:30.487] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:30.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:60:0) after 1m0s
[01:43:30.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:60:0)
[01:43:30.517] Timer tick, asking Buildbucket for the build status
[01:43:30.755] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:30.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:61:0) after 1m0s
[01:44:30.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:61:0)
[01:44:30.782] Timer tick, asking Buildbucket for the build status
[01:44:30.902] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:30.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:62:0) after 1m0s
[01:45:30.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:62:0)
[01:45:30.915] Timer tick, asking Buildbucket for the build status
[01:45:31.214] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:31.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:63:0) after 1m0s
[01:46:31.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:63:0)
[01:46:31.239] Timer tick, asking Buildbucket for the build status
[01:46:31.642] Build 8886076683332489952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:31.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051506745269815536:64:0) after 1m0s
[01:46:45.665] Received PubSub notification, asking Buildbucket for the build status
[01:46:45.902] Build 8886076683332489952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:46:45.902] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583977604486765",
"created_by": "project:chromium",
"created_ts": "1583973915697936",
"id": "8886076683332489952",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2\"}}",
"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\"}, \"$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-100-iemt\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169631, \"got_angle_revision\": \"90a8af383cf9173b36ed17ca5a2ec6df9fd0dbc7\", \"got_dawn_revision\": \"421684f9438d2c847b1c6571055074272d15c089\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2\", \"got_revision_cp\": \"refs/heads/master@{#749443}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"7e857092052e74bdba8017e211b4f91442be29e2\", \"got_v8_revision\": \"918e2ad1cc89520b859e1e6005f599f337e32d01\", \"got_v8_revision_cp\": \"refs/heads/8.2.300@{#1}\", \"got_webrtc_revision\": \"d8d15937da6d6bc76c5b8411e08cb2b18ca0b07b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30767}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2\", \"swarm_hashes_refs/heads/master(at){#749443}_without_patch\": {\"accessibility_unittests\": \"7fb194cd473b37dee0474e623b162042963a2b2c\", \"angle_unittests\": \"29759892558eb4130af982a4306d832222e5a800\", \"app_shell_unittests\": \"49c9b51bfcd3c569b8d0aa18aa8900efff81a5f8\", \"aura_unittests\": \"270fc4ec8a73bfab999f0b98fa97ad7cdc9b4895\", \"base_unittests\": \"f0955c7c413f4e2bbe592dcf539896e7e03b8690\", \"base_util_unittests\": \"bdbc5a3b1376267ce4bbf3dbd7caca4d7d292725\", \"blink_common_unittests\": \"9e993871c91c559bc22f90815f08fef181f37ddb\", \"blink_fuzzer_unittests\": \"b2835f9cd548fdf5366551cb1e847b7495f31315\", \"blink_heap_unittests\": \"44607f0474f1e352e544440cdc1f5cd46540aa86\", \"blink_platform_unittests\": \"9b66a92bd098f860f53e0ccbae13b6604d7d90ca\", \"blink_python_tests\": \"378c85e50d27adf2f6bbf58891b7fdfdd26e50e2\", \"blink_unittests\": \"b043d8653fb94253cf98c08d39a0f8fa49a0d32c\", \"blink_web_tests\": \"0aa6b85ed4c511676408708d5ed67ba85b6bc925\", \"boringssl_crypto_tests\": \"e20a9689401687f1e7f244dbcb80e810dea6f8a9\", \"boringssl_ssl_tests\": \"e5f5bc076e85fe57138ac6ca4322622b48ee29fd\", \"browser_tests\": \"74f7a77cdfd01c01da598c427cdbc69de357e388\", \"cacheinvalidation_unittests\": \"7f042b957529432b5c25f801b84c858aea345b7e\", \"capture_unittests\": \"fa76997afe44b3eca197d27294918b8bd979b67f\", \"cast_unittests\": \"caebeed0f9e0ac67bcd32f17c51054b55a02b394\", \"cc_unittests\": \"4e1bbff9d450e6f75c5a9edb047fccb402ac1dbd\", \"chrome_app_unittests\": \"ceb8a33021f2aa69d0a4cc25bd13ece63c15f4e0\", \"chromedriver_unittests\": \"b20fbf6d657f1d2ea2e26ce61f874065c56e4a45\", \"components_browsertests\": \"3e8368c9800c6bf22659b22551103afde3f3c3c2\", \"components_unittests\": \"c963f2eb42ca92e2c6fe7b786e986b899b34bd61\", \"compositor_unittests\": \"b38056cff47b58249c672a345635664a3f96ddd7\", \"content_browsertests\": \"5cec7946cb2c1740b085439fec8ebce8440a5ae7\", \"content_shell_crash_test\": \"d53e513351ad195cd4e7133278c8e56f8cec48be\", \"content_unittests\": \"1226892c380ef92885f67fea7375f68119ffa6ff\", \"crashpad_tests\": \"57a8f6b6b2803c60a58ddf89b1075980d81ea9ad\", \"cronet_tests\": \"89073b336cbc50e5845800568b2b5685094c6988\", \"cronet_unittests\": \"96115a9b87f06cea8c730cbf169f9169a639b6ea\", \"crypto_unittests\": \"111296ad269bcc828dfeb061e3533813b3665e73\", \"dbus_unittests\": \"a3bcc35bd070a5eb85666a41914e7ba867601c88\", \"device_unittests\": \"68cbc1d512fe1bff9e7ce1d419daea9b17c64c23\", \"display_unittests\": \"2934d5b8375b1774293dbd31865c768c89c3d4e7\", \"events_unittests\": \"1eaa28e789b9b0fbf7a7c0f3bcaae8b751fb56eb\", \"extensions_browsertests\": \"6c74f22119af9483ddab267e9073983cbad1690e\", \"extensions_unittests\": \"e17bc1b0b28501a073bd19013c260d16862baeb5\", \"filesystem_service_unittests\": \"63cffdb001a1d4eeb44273a9572c5d20f458706a\", \"flatbuffers_unittests\": \"0eefb95c23ed43cdbbd4a53788f9cd8b48581ad6\", \"gcm_unit_tests\": \"be4ca7688d8eed75a1569990d75dd4bbc36cc38a\", \"gfx_unittests\": \"8bfa674a2eee4250d11283a3808817ca86b96819\", \"gin_unittests\": \"7fcb6478137fc34883c076d70a9a706807621d32\", \"google_apis_unittests\": \"38b7bb12b4698cffd3158bbaef5537905d4a28e6\", \"gpu_unittests\": \"62e99fb9305a3befb38d45e5043811033ccb0055\", \"grit_python_unittests\": \"f5fdde22ab94b64ae733a1cb2e3ac6512612c7c9\", \"gwp_asan_unittests\": \"b57dd18d62ef3d5ddbffdaf925caac4b08760af2\", \"headless_browsertests\": \"25d6aeca2f5a1869673dcb657bbbf15ca427161f\", \"headless_unittests\": \"7e506fee3f26af21afb2d8dc2bc90d56866653e4\", \"interactive_ui_tests\": \"e222c9b37c522903b047344ba2556b55845a0c36\", \"ipc_tests\": \"f431460108482a3ac4060099881607c10d74fde5\", \"jingle_unittests\": \"88bdc9cdd09943a940fec7e5e96995efff3ed2c0\", \"latency_unittests\": \"570f2b573f5308228d51ca232b869055c90ed3dd\", \"libjingle_xmpp_unittests\": \"5c10da91f20cf594554a74e7d3dc7faf6f744893\", \"media_blink_unittests\": \"756989b4294527a89b87874c2135a1ccca332778\", \"media_service_unittests\": \"5112fa45305eaa5d0b5c7df1e075f6107463cf39\", \"media_unittests\": \"cbdd1fea3dff1212475700e45296d5c34acd1dc4\", \"message_center_unittests\": \"0be5953127df381f19ab09d2ad291fb951903ad2\", \"metrics_python_tests\": \"3bfbbb78f8459e326f5146edaa4eaf7014023252\", \"midi_unittests\": \"217cc75994dac980c6e4b81eee650e0a34237512\", \"mojo_core_unittests\": \"29f59dbb428dc68e04e27c48f1d7507fde8419d6\", \"mojo_unittests\": \"3b48faf4d4cb9424226f7ec773e858b485ce77af\", \"nacl_helper_nonsfi_unittests\": \"f7bbcaa87125fe9cd98661f7e256b38d10d2d170\", \"nacl_loader_unittests\": \"95ec77b3721e86643ddb871b3c455b38148e42a9\", \"native_theme_unittests\": \"0dc8947fb75d4cf05c76039759faae288e902692\", \"net_unittests\": \"e09b6b5f1480fc0a540493f6eb5814b3c7f300ba\", \"pdf_unittests\": \"0931786476480ecd2162892d8153e9c8b4fd23f3\", \"perfetto_unittests\": \"c3710ecf1a8e84db4875d952d056e46a2212312f\", \"ppapi_unittests\": \"2f265909f2bbec6fc36cb81be80d5459565cfc3b\", \"printing_unittests\": \"ab4e28edad04fad9deddf251756285b23c68b093\", \"remoting_unittests\": \"d7664a30755a944471da285de8225d8da1eb688f\", \"sandbox_linux_unittests\": \"16974b3b00eab1ccfcbedc20aa6c2a6bb2169719\", \"service_manager_unittests\": \"9fa67b16c6c8585c233fb9103e9098f1ccb3bceb\", \"services_unittests\": \"016941295679df4e827aceaa4523f1757b8220bb\", \"shell_dialogs_unittests\": \"e8b09b10b9ceabfc9e261412ac9ad3aa4a4d6c35\", \"skia_unittests\": \"2590c4a8b02bbcb00edb6e42d87b7475ae52b645\", \"snapshot_unittests\": \"db98923447e2db99a5cece503a9f9521b0fa00ef\", \"sql_unittests\": \"0acbd99ebb7e7b42aae2589d6146aeeeecbab89a\", \"storage_unittests\": \"d309c9932023008cddac4970d18d68eb751668d6\", \"sync_integration_tests\": \"4c4f532d0674bc72a846a423c7a09fe7fbb655bc\", \"telemetry_gpu_unittests\": \"405636ba41468317310e01792fedb8745f84719f\", \"telemetry_perf_unittests\": \"fb30534f7c7facab6e14ed86b1d19042e90fb63f\", \"telemetry_unittests\": \"6f829fcabff42288458512cadbe541ddfe5bcee2\", \"traffic_annotation_auditor_unittests\": \"f8ee64411dfbc19cc17307ea9096a7f2ca7549fa\", \"ui_base_unittests\": \"82f3bb663d0e86669df5e9e835133ce9a7d3c210\", \"ui_touch_selection_unittests\": \"044857a4aad1e765bd51000d645afe7a94854d91\", \"unit_tests\": \"80663ae79a40552c38c694b80329a14831a4ea98\", \"url_unittests\": \"93b9bcb90e45f203acc5a044ff1f0e780edfab1e\", \"views_perftests\": \"48862a59618ee0e8f85b0a271acc9df0a2abbd6b\", \"views_unittests\": \"195a20d50b6876474838c6ebe8dd7d182d02f5e8\", \"viz_unittests\": \"06c2b44d2b3be5150e4f0e79646266400f3c7be9\", \"vr_common_unittests\": \"0d81cf3ca198444cd5eec049dd3d4d1af6bc767a\", \"vr_pixeltests\": \"bf27f66e29537b9b5d852ea438a1b5e52a812954\", \"webdriver_wpt_tests\": \"5b55615950b515dd2ac410a220b19f34bc206c36\", \"weblayer_browsertests\": \"918188e0c91bddae427eb9544745d98020c804bd\", \"wm_unittests\": \"bdd7175c408b7d0c6afb0dd63fde4d2cac8cdf2e\", \"wtf_unittests\": \"3a0af9234278ef28b60d16531811a10a248d7da3\", \"xr_browser_tests\": \"1b48beb1ea0cb7d3adb6fcef5c1b314620bc6361\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51603c189459d949c9f9b05c6193f37cd30704e77931c7dc651854102fbe3f3d_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-100-iemt\"], \"image\": [\"chrome-xenial-20030800-300841f894e\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583974212109586",
"status": "COMPLETED",
"status_changed_ts": "1583977605169590",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169631",
"builder:Linux Builder (dbg)",
"buildset:commit/git/aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa3dccfd2ecf72089e7d0dcde5fa2f3c28b23ac2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051506745269815536",
"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/8886076683332489952/+/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:4ae50566defe3f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583977605177273",
"url": "https://ci.chromium.org/b/8886076683332489952",
"utcnow_ts": "1583977605889522"
}
}
[01:46:45.902] Invocation finished in 1h1m31.435862692s with status SUCCEEDED