[07:01:42.577] New invocation is queued and will start shortly
[07:01:44.103] Starting the invocation (attempt 1)
[07:01:44.171] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:01:44.171] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:01:44.171] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9049671120629626304",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"df72cfe5332c81fead127c9ecb9e9c1d9e892a15\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9049671120629626304",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/df72cfe5332c81fead127c9ecb9e9c1d9e892a15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/df72cfe5332c81fead127c9ecb9e9c1d9e892a15",
"gitiles_ref:refs/heads/master"
]
}
[07:01:45.499] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585724504301566",
"id": "8884241058136266080",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"df72cfe5332c81fead127c9ecb9e9c1d9e892a15\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585724505258095",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170475",
"builder:Linux Builder (dbg)",
"buildset:commit/git/df72cfe5332c81fead127c9ecb9e9c1d9e892a15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/df72cfe5332c81fead127c9ecb9e9c1d9e892a15",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049671120629626304",
"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/8884241058136266080/+/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": "1585724505258229",
"url": "https://ci.chromium.org/b/8884241058136266080",
"utcnow_ts": "1585724505474838"
}
}
[07:01:45.499] Task URL: https://ci.chromium.org/b/8884241058136266080
[07:01:45.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:2:0) after 1m0s
[07:02:45.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:2:0)
[07:02:45.555] Timer tick, asking Buildbucket for the build status
[07:02:45.719] Build 8884241058136266080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:45.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:3:0) after 1m0s
[07:03:45.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:3:0)
[07:03:45.856] Timer tick, asking Buildbucket for the build status
[07:03:46.005] Build 8884241058136266080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:46.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:4:0) after 1m0s
[07:04:46.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:4:0)
[07:04:46.018] Timer tick, asking Buildbucket for the build status
[07:04:46.237] Build 8884241058136266080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:46.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:5:0) after 1m0s
[07:05:46.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:5:0)
[07:05:46.334] Timer tick, asking Buildbucket for the build status
[07:05:46.509] Build 8884241058136266080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:46.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:6:0) after 1m0s
[07:06:06.446] Received PubSub notification, asking Buildbucket for the build status
[07:06:06.627] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:46.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:6:0)
[07:06:46.542] Timer tick, asking Buildbucket for the build status
[07:06:46.798] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:46.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:8:0) after 1m0s
[07:07:47.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:8:0)
[07:07:47.135] Timer tick, asking Buildbucket for the build status
[07:07:47.331] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:47.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:9:0) after 1m0s
[07:08:47.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:9:0)
[07:08:47.499] Timer tick, asking Buildbucket for the build status
[07:08:48.128] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:48.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:10:0) after 1m0s
[07:09:48.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:10:0)
[07:09:48.368] Timer tick, asking Buildbucket for the build status
[07:09:48.445] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:48.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:11:0) after 1m0s
[07:10:48.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:11:0)
[07:10:48.421] Timer tick, asking Buildbucket for the build status
[07:10:48.590] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:48.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:12:0) after 1m0s
[07:11:48.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:12:0)
[07:11:48.655] Timer tick, asking Buildbucket for the build status
[07:11:48.783] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:48.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:13:0) after 1m0s
[07:12:48.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:13:0)
[07:12:48.847] Timer tick, asking Buildbucket for the build status
[07:12:49.029] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:49.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:14:0) after 1m0s
[07:13:49.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:14:0)
[07:13:49.084] Timer tick, asking Buildbucket for the build status
[07:13:49.252] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:49.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:15:0) after 1m0s
[07:14:49.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:15:0)
[07:14:49.233] Timer tick, asking Buildbucket for the build status
[07:14:49.441] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:49.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:16:0) after 1m0s
[07:15:49.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:16:0)
[07:15:49.482] Timer tick, asking Buildbucket for the build status
[07:15:49.927] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:49.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:17:0) after 1m0s
[07:16:49.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:17:0)
[07:16:49.948] Timer tick, asking Buildbucket for the build status
[07:16:50.163] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:50.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:18:0) after 1m0s
[07:17:50.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:18:0)
[07:17:50.247] Timer tick, asking Buildbucket for the build status
[07:17:50.414] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:50.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:19:0) after 1m0s
[07:18:50.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:19:0)
[07:18:50.461] Timer tick, asking Buildbucket for the build status
[07:18:51.238] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:51.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:20:0) after 1m0s
[07:19:51.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:20:0)
[07:19:51.301] Timer tick, asking Buildbucket for the build status
[07:19:51.395] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:51.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:21:0) after 1m0s
[07:20:51.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:21:0)
[07:20:51.498] Timer tick, asking Buildbucket for the build status
[07:20:52.173] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:52.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:22:0) after 1m0s
[07:21:52.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:22:0)
[07:21:52.291] Timer tick, asking Buildbucket for the build status
[07:21:52.466] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:52.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:23:0) after 1m0s
[07:22:53.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:23:0)
[07:22:53.434] Timer tick, asking Buildbucket for the build status
[07:22:53.573] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:53.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:24:0) after 1m0s
[07:23:53.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:24:0)
[07:23:53.606] Timer tick, asking Buildbucket for the build status
[07:23:53.815] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:53.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:25:0) after 1m0s
[07:24:53.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:25:0)
[07:24:53.834] Timer tick, asking Buildbucket for the build status
[07:24:54.385] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:54.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:26:0) after 1m0s
[07:25:54.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:26:0)
[07:25:54.406] Timer tick, asking Buildbucket for the build status
[07:25:54.649] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:54.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:27:0) after 1m0s
[07:26:54.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:27:0)
[07:26:54.768] Timer tick, asking Buildbucket for the build status
[07:26:54.955] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:54.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:28:0) after 1m0s
[07:27:54.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:28:0)
[07:27:54.959] Timer tick, asking Buildbucket for the build status
[07:27:55.118] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:55.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:29:0) after 1m0s
[07:28:55.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:29:0)
[07:28:55.162] Timer tick, asking Buildbucket for the build status
[07:28:55.481] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:55.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:30:0) after 1m0s
[07:29:55.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:30:0)
[07:29:55.535] Timer tick, asking Buildbucket for the build status
[07:29:55.880] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:55.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:31:0) after 1m0s
[07:30:55.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:31:0)
[07:30:55.906] Timer tick, asking Buildbucket for the build status
[07:30:56.097] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:56.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:32:0) after 1m0s
[07:31:56.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:32:0)
[07:31:56.124] Timer tick, asking Buildbucket for the build status
[07:31:56.507] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:56.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:33:0) after 1m0s
[07:32:56.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:33:0)
[07:32:56.558] Timer tick, asking Buildbucket for the build status
[07:32:56.693] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:56.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:34:0) after 1m0s
[07:33:56.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:34:0)
[07:33:56.744] Timer tick, asking Buildbucket for the build status
[07:33:57.092] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:57.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:35:0) after 1m0s
[07:34:57.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:35:0)
[07:34:57.169] Timer tick, asking Buildbucket for the build status
[07:34:57.302] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:57.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:36:0) after 1m0s
[07:35:57.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:36:0)
[07:35:57.369] Timer tick, asking Buildbucket for the build status
[07:35:57.536] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:57.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:37:0) after 1m0s
[07:36:57.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:37:0)
[07:36:57.541] Timer tick, asking Buildbucket for the build status
[07:36:58.016] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:58.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:38:0) after 1m0s
[07:37:58.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:38:0)
[07:37:58.102] Timer tick, asking Buildbucket for the build status
[07:37:58.230] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:58.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:39:0) after 1m0s
[07:38:58.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:39:0)
[07:38:58.292] Timer tick, asking Buildbucket for the build status
[07:38:58.789] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:58.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:40:0) after 1m0s
[07:39:58.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:40:0)
[07:39:58.833] Timer tick, asking Buildbucket for the build status
[07:39:59.088] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:59.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:41:0) after 1m0s
[07:40:59.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:41:0)
[07:40:59.128] Timer tick, asking Buildbucket for the build status
[07:40:59.272] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:59.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:42:0) after 1m0s
[07:41:59.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:42:0)
[07:41:59.358] Timer tick, asking Buildbucket for the build status
[07:41:59.748] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:59.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:43:0) after 1m0s
[07:42:59.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:43:0)
[07:42:59.922] Timer tick, asking Buildbucket for the build status
[07:43:00.422] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:00.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:44:0) after 1m0s
[07:44:00.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:44:0)
[07:44:00.514] Timer tick, asking Buildbucket for the build status
[07:44:00.705] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:00.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:45:0) after 1m0s
[07:45:00.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:45:0)
[07:45:00.783] Timer tick, asking Buildbucket for the build status
[07:45:01.172] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:01.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:46:0) after 1m0s
[07:46:01.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:46:0)
[07:46:01.217] Timer tick, asking Buildbucket for the build status
[07:46:01.400] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:01.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:47:0) after 1m0s
[07:47:01.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:47:0)
[07:47:01.440] Timer tick, asking Buildbucket for the build status
[07:47:01.913] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:01.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:48:0) after 1m0s
[07:48:01.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:48:0)
[07:48:01.936] Timer tick, asking Buildbucket for the build status
[07:48:02.705] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:02.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:49:0) after 1m0s
[07:49:02.747] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:49:0)
[07:49:02.747] Timer tick, asking Buildbucket for the build status
[07:49:05.385] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:05.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:50:0) after 1m0s
[07:50:05.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:50:0)
[07:50:05.550] Timer tick, asking Buildbucket for the build status
[07:50:05.701] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:05.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:51:0) after 1m0s
[07:51:05.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:51:0)
[07:51:05.796] Timer tick, asking Buildbucket for the build status
[07:51:05.963] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:05.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:52:0) after 1m0s
[07:52:05.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:52:0)
[07:52:05.992] Timer tick, asking Buildbucket for the build status
[07:52:06.140] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:06.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:53:0) after 1m0s
[07:53:06.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:53:0)
[07:53:06.229] Timer tick, asking Buildbucket for the build status
[07:53:06.398] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:06.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:54:0) after 1m0s
[07:54:06.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:54:0)
[07:54:06.451] Timer tick, asking Buildbucket for the build status
[07:54:06.607] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:06.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:55:0) after 1m0s
[07:55:06.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:55:0)
[07:55:06.665] Timer tick, asking Buildbucket for the build status
[07:55:06.842] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:06.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:56:0) after 1m0s
[07:56:06.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:56:0)
[07:56:06.870] Timer tick, asking Buildbucket for the build status
[07:56:07.032] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:07.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:57:0) after 1m0s
[07:57:07.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:57:0)
[07:57:07.098] Timer tick, asking Buildbucket for the build status
[07:57:07.492] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:07.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:58:0) after 1m0s
[07:58:07.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:58:0)
[07:58:07.564] Timer tick, asking Buildbucket for the build status
[07:58:08.282] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:08.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:59:0) after 1m0s
[07:59:08.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:59:0)
[07:59:08.403] Timer tick, asking Buildbucket for the build status
[07:59:08.535] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:08.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:60:0) after 1m0s
[08:00:08.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:60:0)
[08:00:08.564] Timer tick, asking Buildbucket for the build status
[08:00:08.958] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:08.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:61:0) after 1m0s
[08:01:09.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:61:0)
[08:01:09.701] Timer tick, asking Buildbucket for the build status
[08:01:11.264] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:11.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:62:0) after 1m0s
[08:02:11.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:62:0)
[08:02:11.353] Timer tick, asking Buildbucket for the build status
[08:02:11.493] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:11.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:63:0) after 1m0s
[08:03:11.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:63:0)
[08:03:11.587] Timer tick, asking Buildbucket for the build status
[08:03:12.148] Build 8884241058136266080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:12.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9049671120629626304:64:0) after 1m0s
[08:04:01.791] Received PubSub notification, asking Buildbucket for the build status
[08:04:02.176] Build 8884241058136266080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:04:02.176] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585728240833600",
"created_by": "project:chromium",
"created_ts": "1585724504301566",
"id": "8884241058136266080",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"df72cfe5332c81fead127c9ecb9e9c1d9e892a15\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$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-east1-d-8-64-isok\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170475, \"got_angle_revision\": \"4b94d7bb4fbed9018d198dfdc50c3aa5f9be3ddf\", \"got_dawn_revision\": \"3da19b843ffd63d884f3a67f2da3eea20818499a\", \"got_nacl_revision\": \"ebf11aaad97fde7f91b1c72e0dddaf1653d41f77\", \"got_revision\": \"df72cfe5332c81fead127c9ecb9e9c1d9e892a15\", \"got_revision_cp\": \"refs/heads/master@{#755262}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"5cf1e9a31c90ccd9ec40d0c5ef1357f6e0ec1cfd\", \"got_v8_revision\": \"0169ff3922e0a1a485f8d802b3503d5bb833161d\", \"got_v8_revision_cp\": \"refs/heads/8.3.111@{#1}\", \"got_webrtc_revision\": \"00b46f7f2ad1af482a9fd104627f32cb5d9ba45c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30953}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"df72cfe5332c81fead127c9ecb9e9c1d9e892a15\", \"swarm_hashes_refs/heads/master(at){#755262}_without_patch\": {\"accessibility_unittests\": \"2c84158561fafbedc7578f1a591fc963bfa9341d\", \"angle_unittests\": \"5063d5a6aafeee2a449c58d1125d94e8f68fc0c2\", \"app_shell_unittests\": \"6dc01a5de830ee1af8453d6c15372e545ac255ab\", \"aura_unittests\": \"96d761c6d2bbf9b47968eb8c5d95dc65fdf0d02e\", \"base_unittests\": \"a3ab1cda6d9855638cb3a27367906c02484758f4\", \"base_util_unittests\": \"064abcd23d791775ee2bbf9d32a1cda8cc91c3dc\", \"blink_common_unittests\": \"d6ad8e1a0df8e871f15b0fbef3f68b4b4265003e\", \"blink_fuzzer_unittests\": \"3ebc577f5f4f807d4dd5882c75908f7712f772e0\", \"blink_heap_unittests\": \"05e2807d999134101fc66e9c690e712680ede3cf\", \"blink_platform_unittests\": \"e94716c8d23022bb607e7dac4089041e267b16de\", \"blink_python_tests\": \"4e7565b0827a8b7005d8c5e3d691c7a62f13d2fb\", \"blink_unittests\": \"2d2414a661562876e5dce1f69ddb4837b939ff39\", \"blink_web_tests\": \"fa457bf3a564ec50d15cd224e790589e1b895476\", \"boringssl_crypto_tests\": \"b53ef80a7ced43800b34c942aca1059889b35fcc\", \"boringssl_ssl_tests\": \"6a56744374c748562234cfa1750fd131ad2607ec\", \"browser_tests\": \"a7d5200468e8a37d6ae6efffac34d3d38d67470e\", \"cacheinvalidation_unittests\": \"2a06e20316d5a1fd57115fff692d8ba3d8655937\", \"capture_unittests\": \"6c4582d8dbab72e67fa83912bfaa1df3cdbc0230\", \"cast_unittests\": \"54e8376215dd89c7e8dc27c0e1cf7e628ce68c09\", \"cc_unittests\": \"628a94b86f5dc1ea854eaedebfd2ef6f15d3ab1b\", \"chrome_app_unittests\": \"4d464ea9de6d9175ebeb54aa31e76061714bf65e\", \"chromedriver_unittests\": \"e718b5ab6c9c2fe1569799fe3fe9cc4efb619ee1\", \"components_browsertests\": \"fb77efe49fbb84d725ceee2e8e019d6f12628c17\", \"components_unittests\": \"c82d9941d9e85d652915116bd01934bdad36a025\", \"compositor_unittests\": \"9021c97fd8a3b6844852955175d71f4ceb2b9ab9\", \"content_browsertests\": \"8cb1aa6bdf6c10774238b30849d718454b9a52ff\", \"content_shell_crash_test\": \"b5670a7755247564df640a3345ac03846e96f453\", \"content_unittests\": \"a1926b0d55b05b795fe12bb4a170907308d03e27\", \"crashpad_tests\": \"6a11c237295a4f5a822edb1149de5c23b2d41d5d\", \"cronet_tests\": \"86957b3fa1eacf06bc2ddfe10af3cea8889d5ca6\", \"cronet_unittests\": \"52f624d71e396f6e8feb0994dd01302408921eca\", \"crypto_unittests\": \"59dc6631527404166d8f7e3b0055c13b7ee9ba0e\", \"dbus_unittests\": \"bc626c42aa8b79f69b80a684212b331475e4536d\", \"device_unittests\": \"c14695b9f883b3980bb84bafdc58b40b374c6cdd\", \"display_unittests\": \"710945d49a68dc3ab483bba6b9a37d2c2b21d8a2\", \"events_unittests\": \"fb1334c3f4ee5e3c94d9533184d115f4e6dec958\", \"extensions_browsertests\": \"0abcd1c99d8bd45f65d8b0d7fcf05b126dec4df5\", \"extensions_unittests\": \"58fcd9793d8ce0e2a3013b0e8f5c5373c30a48aa\", \"filesystem_service_unittests\": \"5f23204f85c263e93faa1923ba60082b72cb9b31\", \"flatbuffers_unittests\": \"72ac4f314db80fab790f3135fe10fde26e7da08e\", \"gcm_unit_tests\": \"ce70d924f79b38062011f5be3a866c2b0c9ab605\", \"gfx_unittests\": \"2afba858103dbc6a6e745bf5bb5d608d7a1ab5ac\", \"gin_unittests\": \"abcbb72abb911b7e9f50b175ab56554ebe11dd92\", \"google_apis_unittests\": \"fd8be7dcf50adca6fb61f08c4608fd082631ff97\", \"gpu_unittests\": \"904c4de10fde7c129e66cfc1d0035267155ccb97\", \"grit_python_unittests\": \"8c3aba08684a4851b7eb5e55316c1cdda2ef1701\", \"gwp_asan_unittests\": \"73e856c4c4e972512fcd2fee04dbbea2cc9ac227\", \"headless_browsertests\": \"bb8c753192bb4b225a65605cc55264e70914c3a3\", \"headless_unittests\": \"95ecbb6018b5f3c02fd1651c36c60dafb89bdc6a\", \"interactive_ui_tests\": \"927ccdaccab0023af1677fcd3ad76b86cabf2a1e\", \"ipc_tests\": \"bf7cb9c083f18ec5c44ad954dae212b6ef2e57e0\", \"jingle_unittests\": \"22b49e9fed1fdf48163e1e260db053423dad2ac1\", \"latency_unittests\": \"5165fe8b049cb0c298711a28c69e174439fbdad2\", \"libjingle_xmpp_unittests\": \"94248fc388523994d650b8796d3ea739fafa0813\", \"media_blink_unittests\": \"8ede06d026d91e022a0b47640bce6449f5b3bd57\", \"media_unittests\": \"c507de23d6cebf9afb0eaba9f49cc805c1d4bcfc\", \"message_center_unittests\": \"4a173f8af5ede92b357c96c4ec2a8e4383033bff\", \"metrics_python_tests\": \"3c0a71b0a112a00e63841bcacf8750ce6dafb44b\", \"midi_unittests\": \"7391b7d03f75d27bd61e15b9630ecab01be7ad1d\", \"mojo_core_unittests\": \"a213d1e46de01cb4ea71225002d7e2905379216d\", \"mojo_unittests\": \"5e27c283de2c47058ea1c29b0e547e3b011afe7a\", \"nacl_helper_nonsfi_unittests\": \"5f2c609da47e1006c5639a67fb5d8210763e47ed\", \"nacl_loader_unittests\": \"8643d0680e1b7e9abaf12b1f9167f88a4c2f5118\", \"native_theme_unittests\": \"b6e0a0abddf11c7b9c499ed3c6e47d1ba6d3ec8d\", \"net_unittests\": \"736321f15d374596ade32a9f2ecfac276ceaf214\", \"pdf_unittests\": \"75c140055b85c152a9e33cabd6c20347e02a6771\", \"perfetto_unittests\": \"852b1680e63076f5cdb27e36053ced47572fbe53\", \"ppapi_unittests\": \"25b054f81ca757b30f9b7a29f642017cf20f4ef0\", \"printing_unittests\": \"431b7d9ec9edebbbfd8a23e12865e2689164e3a3\", \"remoting_unittests\": \"a0f1b5fc29b898ae8e7bb224946ae3b7930466fb\", \"sandbox_linux_unittests\": \"fc24d6748c18a78e760832cf27477970fcb11035\", \"service_manager_unittests\": \"50d01d27b1ca35e943e64a595585a9d17e6a0fec\", \"services_unittests\": \"050e19cc1ddf8ad0c0c681b4ddadbbc727bb3fa4\", \"shell_dialogs_unittests\": \"f7f246b13c60011c82321c12d858e7bbcda3a653\", \"skia_unittests\": \"c622264b127a90beec57190e8645c5c320fd9bb7\", \"snapshot_unittests\": \"081e999e45a04e841a651906a675da404f8b43f2\", \"sql_unittests\": \"18dbb1e4fb600b42d5720ff539298e8abcf08053\", \"storage_unittests\": \"4d98e65485e0f33d38b115bd19e0173d94b974ab\", \"sync_integration_tests\": \"a127ecaba7d642e56b450600817cdc9f7be56d95\", \"telemetry_gpu_unittests\": \"a89521ef68a34a319ac29a627c6db63e2443558f\", \"telemetry_perf_unittests\": \"cdfb0756284e532a5d64c5af7ae6d7ea5a094c33\", \"telemetry_unittests\": \"351155462764c1db4ad4e7751956bc499285acf3\", \"traffic_annotation_auditor_unittests\": \"32c4021b8cd9cc5fcedb1b1176d5972555dd89d4\", \"ui_base_unittests\": \"f83b2caef9e31ec1d89c6414f7e9a775d45ed879\", \"ui_touch_selection_unittests\": \"e39661be3a45639b2a3e097a1d9e30b28b48624b\", \"unit_tests\": \"60141932fdd8c5fa4b29086138a0f02de7349e0a\", \"url_unittests\": \"b8898750dd1716d4b182dd10e5717cb7279e3716\", \"views_perftests\": \"a107335f85150464c4f7de7f09f5e65345b54848\", \"views_unittests\": \"eb3830110d2a568c5d694cac56845a1acdd5a551\", \"viz_unittests\": \"04e894d91fe4e79f4e19007b0d73f394aaf5d6a5\", \"vr_common_unittests\": \"c1708753619dc093750a0cf82e0f1330b7be9526\", \"vr_pixeltests\": \"3abc2713d920fbe6b67f520bad6d909aec139ca4\", \"webdriver_wpt_tests\": \"acf3fcfd75dbade23012b9bcdd584d2d83e762c8\", \"weblayer_browsertests\": \"a9c584e46a87eef820f89f0ab8f7d88bb543d283\", \"wm_unittests\": \"3799f20bf9e87aeeb8dac361089ecd5ef72e37d4\", \"wtf_unittests\": \"0d41ea0952df9c2d4c94cce85c9b29c0f9f5f464\", \"xr_browser_tests\": \"48ac2a928521e77508b3e87d63020fc8e5a2a1d6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-east1-d-8-64-isok\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"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\": [\"4916-b2318d4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585724764374678",
"status": "COMPLETED",
"status_changed_ts": "1585728241252692",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170475",
"builder:Linux Builder (dbg)",
"buildset:commit/git/df72cfe5332c81fead127c9ecb9e9c1d9e892a15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/df72cfe5332c81fead127c9ecb9e9c1d9e892a15",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9049671120629626304",
"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/8884241058136266080/+/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:4b4d5d46e56be310",
"user_agent:luci-scheduler"
],
"updated_ts": "1585728241258255",
"url": "https://ci.chromium.org/b/8884241058136266080",
"utcnow_ts": "1585728242159409"
}
}
[08:04:02.176] Invocation finished in 1h2m19.635820494s with status SUCCEEDED