[09:21:40.314] New invocation is queued and will start shortly
[09:21:41.488] Starting the invocation (attempt 1)
[09:21:41.523] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:21:41.523] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:21:41.523] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057000669227275008",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eb5c90d6340bfbdc8b24621fab16be4d97e343d5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9057000669227275008",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/eb5c90d6340bfbdc8b24621fab16be4d97e343d5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb5c90d6340bfbdc8b24621fab16be4d97e343d5",
"gitiles_ref:refs/heads/master"
]
}
[09:21:42.485] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578734501685069",
"id": "8891570607119857520",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eb5c90d6340bfbdc8b24621fab16be4d97e343d5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578734502264871",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167261",
"builder:Linux Builder (dbg)",
"buildset:commit/git/eb5c90d6340bfbdc8b24621fab16be4d97e343d5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb5c90d6340bfbdc8b24621fab16be4d97e343d5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057000669227275008",
"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/8891570607119857520/+/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": "1578734502265011",
"url": "https://ci.chromium.org/b/8891570607119857520",
"utcnow_ts": "1578734502469784"
}
}
[09:21:42.485] Task URL: https://ci.chromium.org/b/8891570607119857520
[09:21:42.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:2:0) after 1m0s
[09:22:42.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:2:0)
[09:22:42.483] Timer tick, asking Buildbucket for the build status
[09:22:43.201] Build 8891570607119857520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:43.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:3:0) after 1m0s
[09:23:43.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:3:0)
[09:23:43.221] Timer tick, asking Buildbucket for the build status
[09:23:43.489] Build 8891570607119857520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:43.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:4:0) after 1m0s
[09:24:43.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:4:0)
[09:24:43.521] Timer tick, asking Buildbucket for the build status
[09:24:45.776] Build 8891570607119857520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:45.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:5:0) after 1m0s
[09:25:45.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:5:0)
[09:25:45.885] Timer tick, asking Buildbucket for the build status
[09:25:46.056] Build 8891570607119857520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:25:46.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:6:0) after 1m0s
[09:26:03.809] Received PubSub notification, asking Buildbucket for the build status
[09:26:03.936] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:6:0)
[09:26:46.131] Timer tick, asking Buildbucket for the build status
[09:26:46.328] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:8:0) after 1m0s
[09:27:46.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:8:0)
[09:27:46.396] Timer tick, asking Buildbucket for the build status
[09:27:46.773] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:46.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:9:0) after 1m0s
[09:28:46.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:9:0)
[09:28:46.947] Timer tick, asking Buildbucket for the build status
[09:28:47.163] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:47.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:10:0) after 1m0s
[09:29:47.248] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:10:0)
[09:29:47.248] Timer tick, asking Buildbucket for the build status
[09:29:47.785] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:47.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:11:0) after 1m0s
[09:30:47.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:11:0)
[09:30:47.769] Timer tick, asking Buildbucket for the build status
[09:30:48.063] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:48.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:12:0) after 1m0s
[09:31:48.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:12:0)
[09:31:48.143] Timer tick, asking Buildbucket for the build status
[09:31:48.484] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:48.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:13:0) after 1m0s
[09:32:48.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:13:0)
[09:32:48.496] Timer tick, asking Buildbucket for the build status
[09:32:48.748] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:14:0) after 1m0s
[09:33:48.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:14:0)
[09:33:48.740] Timer tick, asking Buildbucket for the build status
[09:33:49.595] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:49.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:15:0) after 1m0s
[09:34:49.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:15:0)
[09:34:49.628] Timer tick, asking Buildbucket for the build status
[09:34:49.986] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:49.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:16:0) after 1m0s
[09:35:50.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:16:0)
[09:35:50.104] Timer tick, asking Buildbucket for the build status
[09:35:50.669] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:50.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:17:0) after 1m0s
[09:36:50.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:17:0)
[09:36:50.688] Timer tick, asking Buildbucket for the build status
[09:36:50.925] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:50.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:18:0) after 1m0s
[09:37:51.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:18:0)
[09:37:51.098] Timer tick, asking Buildbucket for the build status
[09:37:51.271] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:51.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:19:0) after 1m0s
[09:38:51.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:19:0)
[09:38:51.355] Timer tick, asking Buildbucket for the build status
[09:38:51.604] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:51.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:20:0) after 1m0s
[09:39:51.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:20:0)
[09:39:51.688] Timer tick, asking Buildbucket for the build status
[09:39:52.402] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:52.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:21:0) after 1m0s
[09:40:52.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:21:0)
[09:40:52.534] Timer tick, asking Buildbucket for the build status
[09:40:53.002] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:53.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:22:0) after 1m0s
[09:41:52.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:22:0)
[09:41:52.987] Timer tick, asking Buildbucket for the build status
[09:41:53.477] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:53.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:23:0) after 1m0s
[09:42:53.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:23:0)
[09:42:53.500] Timer tick, asking Buildbucket for the build status
[09:42:53.778] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:53.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:24:0) after 1m0s
[09:43:53.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:24:0)
[09:43:53.796] Timer tick, asking Buildbucket for the build status
[09:43:54.137] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:54.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:25:0) after 1m0s
[09:44:54.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:25:0)
[09:44:54.195] Timer tick, asking Buildbucket for the build status
[09:44:54.714] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:54.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:26:0) after 1m0s
[09:45:54.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:26:0)
[09:45:54.713] Timer tick, asking Buildbucket for the build status
[09:45:54.995] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:54.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:27:0) after 1m0s
[09:46:55.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:27:0)
[09:46:55.058] Timer tick, asking Buildbucket for the build status
[09:46:55.703] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:55.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:28:0) after 1m0s
[09:47:55.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:28:0)
[09:47:55.772] Timer tick, asking Buildbucket for the build status
[09:47:56.071] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:56.071] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:29:0) after 1m0s
[09:48:56.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:29:0)
[09:48:56.088] Timer tick, asking Buildbucket for the build status
[09:48:56.289] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:56.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:30:0) after 1m0s
[09:49:56.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:30:0)
[09:49:56.325] Timer tick, asking Buildbucket for the build status
[09:49:56.519] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:56.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:31:0) after 1m0s
[09:50:56.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:31:0)
[09:50:56.569] Timer tick, asking Buildbucket for the build status
[09:50:57.544] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:57.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:32:0) after 1m0s
[09:51:57.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:32:0)
[09:51:57.628] Timer tick, asking Buildbucket for the build status
[09:51:57.917] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:57.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:33:0) after 1m0s
[09:52:57.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:33:0)
[09:52:57.994] Timer tick, asking Buildbucket for the build status
[09:52:58.189] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:58.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:34:0) after 1m0s
[09:53:58.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:34:0)
[09:53:58.214] Timer tick, asking Buildbucket for the build status
[09:53:58.552] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:58.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:35:0) after 1m0s
[09:54:58.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:35:0)
[09:54:58.651] Timer tick, asking Buildbucket for the build status
[09:54:59.038] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:59.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:36:0) after 1m0s
[09:55:59.097] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:36:0)
[09:55:59.097] Timer tick, asking Buildbucket for the build status
[09:55:59.309] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:59.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:37:0) after 1m0s
[09:56:59.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:37:0)
[09:56:59.328] Timer tick, asking Buildbucket for the build status
[09:57:00.119] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:00.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:38:0) after 1m0s
[09:58:00.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:38:0)
[09:58:00.137] Timer tick, asking Buildbucket for the build status
[09:58:00.349] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:00.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:39:0) after 1m0s
[09:59:00.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:39:0)
[09:59:00.402] Timer tick, asking Buildbucket for the build status
[09:59:00.573] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:00.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:40:0) after 1m0s
[10:00:00.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:40:0)
[10:00:00.695] Timer tick, asking Buildbucket for the build status
[10:00:01.275] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:01.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:41:0) after 1m0s
[10:01:01.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:41:0)
[10:01:01.295] Timer tick, asking Buildbucket for the build status
[10:01:02.117] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:02.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:42:0) after 1m0s
[10:02:02.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:42:0)
[10:02:02.168] Timer tick, asking Buildbucket for the build status
[10:02:02.615] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:02.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:43:0) after 1m0s
[10:03:02.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:43:0)
[10:03:02.684] Timer tick, asking Buildbucket for the build status
[10:03:02.889] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:02.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:44:0) after 1m0s
[10:04:03.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:44:0)
[10:04:03.006] Timer tick, asking Buildbucket for the build status
[10:04:03.857] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:03.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:45:0) after 1m0s
[10:05:03.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:45:0)
[10:05:03.945] Timer tick, asking Buildbucket for the build status
[10:05:04.266] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:04.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:46:0) after 1m0s
[10:06:04.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:46:0)
[10:06:04.577] Timer tick, asking Buildbucket for the build status
[10:06:04.901] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:04.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:47:0) after 1m0s
[10:07:04.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:47:0)
[10:07:04.972] Timer tick, asking Buildbucket for the build status
[10:07:05.746] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:05.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:48:0) after 1m0s
[10:08:05.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:48:0)
[10:08:05.779] Timer tick, asking Buildbucket for the build status
[10:08:08.901] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:49:0) after 1m0s
[10:09:08.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:49:0)
[10:09:08.941] Timer tick, asking Buildbucket for the build status
[10:09:09.171] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:09.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:50:0) after 1m0s
[10:10:09.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:50:0)
[10:10:09.256] Timer tick, asking Buildbucket for the build status
[10:10:09.443] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:09.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:51:0) after 1m0s
[10:11:09.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:51:0)
[10:11:09.651] Timer tick, asking Buildbucket for the build status
[10:11:09.826] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:09.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:52:0) after 1m0s
[10:12:10.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:52:0)
[10:12:10.333] Timer tick, asking Buildbucket for the build status
[10:12:10.535] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:53:0) after 1m0s
[10:13:10.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:53:0)
[10:13:10.939] Timer tick, asking Buildbucket for the build status
[10:13:11.194] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:11.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:54:0) after 1m0s
[10:14:11.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:54:0)
[10:14:11.487] Timer tick, asking Buildbucket for the build status
[10:14:11.680] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:11.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:55:0) after 1m0s
[10:15:11.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:55:0)
[10:15:11.740] Timer tick, asking Buildbucket for the build status
[10:15:11.995] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:11.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:56:0) after 1m0s
[10:16:11.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:56:0)
[10:16:11.975] Timer tick, asking Buildbucket for the build status
[10:16:12.146] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:12.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:57:0) after 1m0s
[10:17:12.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:57:0)
[10:17:12.462] Timer tick, asking Buildbucket for the build status
[10:17:12.715] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:12.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:58:0) after 1m0s
[10:18:13.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:58:0)
[10:18:13.049] Timer tick, asking Buildbucket for the build status
[10:18:13.300] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:13.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:59:0) after 1m0s
[10:19:13.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:59:0)
[10:19:13.437] Timer tick, asking Buildbucket for the build status
[10:19:14.221] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:14.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:60:0) after 1m0s
[10:20:14.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:60:0)
[10:20:14.712] Timer tick, asking Buildbucket for the build status
[10:20:14.991] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:14.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:61:0) after 1m0s
[10:21:15.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:61:0)
[10:21:15.022] Timer tick, asking Buildbucket for the build status
[10:21:16.072] Build 8891570607119857520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:16.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057000669227275008:62:0) after 1m0s
[10:21:42.143] Received PubSub notification, asking Buildbucket for the build status
[10:21:42.590] Build 8891570607119857520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:21:42.590] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578738101423343",
"created_by": "project:chromium",
"created_ts": "1578734501685069",
"id": "8891570607119857520",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eb5c90d6340bfbdc8b24621fab16be4d97e343d5\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-21-otjp\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167261, \"got_angle_revision\": \"f0be7c81c58180d11c5d2bdd1c83d2c526603286\", \"got_dawn_revision\": \"69c68d01b2420e77283166ffcc7ddb4b0fbc2505\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"eb5c90d6340bfbdc8b24621fab16be4d97e343d5\", \"got_revision_cp\": \"refs/heads/master@{#730419}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5fd905ca96a39ebd9e80a7f793a890465c37e5e4\", \"got_v8_revision\": \"5cc27b0cdcd62fc7dc702cb7769e8bed2d5c1355\", \"got_v8_revision_cp\": \"refs/heads/8.1.158@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eb5c90d6340bfbdc8b24621fab16be4d97e343d5\", \"swarm_hashes_refs/heads/master(at){#730419}_without_patch\": {\"accessibility_unittests\": \"ad9f0e4276454768791854e093ea7c2a395e2604\", \"angle_unittests\": \"e179de6e46a08d6438c75d21129e7a78bf0f2123\", \"app_shell_unittests\": \"4ba05a1f88166829e4cd91f2f9b847628881df92\", \"aura_unittests\": \"63fff95caa5470ab2ecab448953574b3fad0aa41\", \"base_unittests\": \"dcfb20717cf3321c51cd60ee09aa44ecbecc16e1\", \"base_util_unittests\": \"8a56a4bf803f2ce0053bf55552c21bc627f7865c\", \"blink_common_unittests\": \"3b94b8a9ec7148a38f5634e984c1735131e4fc8c\", \"blink_fuzzer_unittests\": \"9139db37c723e5b7c09d04bfe5a75086dd72953d\", \"blink_heap_unittests\": \"c682462bddf1af94273a1d4729bc6dd63c76a0fc\", \"blink_platform_unittests\": \"73b41cefff877b1d2861946d63f89434d9617179\", \"blink_python_tests\": \"4c6414c285aae842bdc5ec3b7e624a82f8c35117\", \"blink_unittests\": \"bc8eeb1d9ca63b8e56c04ebf0b95585a9adae13d\", \"blink_web_tests\": \"d664503708b9a8f090c88e8fe4d9c8102e20edf1\", \"boringssl_crypto_tests\": \"dd7548cb0fad70870d74d3f0d4e482f1b7561105\", \"boringssl_ssl_tests\": \"eafb39c40fe25243674b7abcd1da699b892d9c4b\", \"browser_tests\": \"4b345742506acffb23379d3609f2494d2dd433fa\", \"cacheinvalidation_unittests\": \"0053ed402f757bd3a2a266dfa4bd57697089c12d\", \"capture_unittests\": \"658897c5d2a10727526f981d196ccffc2f34cbb5\", \"cast_unittests\": \"a411afa68bdc9162b4cab72ab2b357ab31df43c9\", \"cc_unittests\": \"09d7a5913db89525c5be17a3405a38755216fde9\", \"chrome_app_unittests\": \"d75d1b85cae65ecddbf6305d693fba41e6da3bee\", \"chromedriver_unittests\": \"1d861fbb4f078887afaf2dd107b3c1504060a30d\", \"components_browsertests\": \"0d5d1d1a69fff73e0968f3930a8676ff82592802\", \"components_unittests\": \"81f82523a9b67df21a2075a3a65a0a329f624a4e\", \"compositor_unittests\": \"7668a2cfa981a9bc2394a148752839e21795b594\", \"content_browsertests\": \"119ef7fc4436773081626902214f8e36ca29d6df\", \"content_shell_crash_test\": \"6158fef0e697ee9e81d8b02e45d5aa074ea72ee7\", \"content_unittests\": \"b54567517b1042ac2b99680a63960994f1d8653a\", \"crashpad_tests\": \"1303201517b75a1f9de5f37cdbfcead72a26ac72\", \"cronet_tests\": \"01fdad86888e1a6f9b6a70c30b7165da2c4216d3\", \"cronet_unittests\": \"41126c7e6069c75584e6a9367039e4d9868787e0\", \"crypto_unittests\": \"f47abb4befa007e67b99ca4b5e5fc2682244a341\", \"dbus_unittests\": \"2c0921affdb5eba06462a4eed221f5c4361b76ee\", \"device_unittests\": \"d31a82f211140096879e0d6b9787b80e4256e0da\", \"devtools_lint_check\": \"7f17475dc8d79f2dca2992b80bc16fd234c1ecea\", \"devtools_type_check\": \"6de97c8b5b796624e7ba22c855f3b9ccd473a186\", \"display_unittests\": \"c3d3844c788cf83cfdbf6a236e1493da21a442d4\", \"events_unittests\": \"ccad5a4dbedd5b0daf121e96741cc010358c1ac2\", \"extensions_browsertests\": \"350e51310432885df019e34348457e7c31be19ea\", \"extensions_unittests\": \"464d627db75016cb9efd8dcec500283052c666c7\", \"filesystem_service_unittests\": \"234c01772f20f85ea02ccd8c866dbe5ccab83d8f\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"3e80f46938ca8711525a827933c58c4fa4badbae\", \"gfx_unittests\": \"d56d0321ce4daeb2e0d6a927dd73dbd23adca0b0\", \"gin_unittests\": \"506472ff3033fa6204b19824125c4c01d5510856\", \"google_apis_unittests\": \"b1e70a7fa051a5626a104183625cac8e1e5efc0e\", \"gpu_unittests\": \"51e17e3f74d0258b1a3db975be0f3f0e679a21cc\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"9876fd2586385f44000552837bd8a8c186989c54\", \"headless_browsertests\": \"e3f664f245fc2777576c072430338f158e3bba26\", \"headless_unittests\": \"d1b3e7e0c32593dd2011647b29dc8bf358e947b0\", \"interactive_ui_tests\": \"2516a32a09b23d7c1ec51ef75163a573927fb6c0\", \"ipc_tests\": \"13e75c1b458bda3af5efbd25da99c5f3985d2221\", \"jingle_unittests\": \"102260434710b0c2af307f1ed488868db868ebad\", \"latency_unittests\": \"73fedaac9dde202fac5e461f8d2d814e50e83c70\", \"libjingle_xmpp_unittests\": \"f6534feb0e1608386013ebbd629a8ec771ee073f\", \"media_blink_unittests\": \"6cd0f0eeb9be8715f1544c8c1e5b76468fbdad8f\", \"media_service_unittests\": \"45cf9341819c750e98ffac7f478fad974bf86987\", \"media_unittests\": \"565f5f4a5de4b5319d1663620b3a356f4018a7a6\", \"message_center_unittests\": \"27f8fdf0091c8b87394b61aaa7c9f2862de1d8d9\", \"metrics_python_tests\": \"1e9f0c497efcb4b39b3855ebc723066d3af32110\", \"midi_unittests\": \"b24a7dee23861238601b05a3b0f0f9d5333a2e4e\", \"mojo_core_unittests\": \"416a9ec6a2f33700859d587f3520a3bb49c7f81b\", \"mojo_unittests\": \"02b266798de825a1eaedbd626b240835bfed996d\", \"nacl_helper_nonsfi_unittests\": \"dc0cca7144d4fd906ed78d4693e49cfd904c4c98\", \"nacl_loader_unittests\": \"8924b259372a3060f14446ac216d477a11391cc9\", \"native_theme_unittests\": \"2c1b3926a690802da2eea6eff38928436b7c813b\", \"net_unittests\": \"46c37d6e57010a4e6185edba94c9a9286ee504f3\", \"pdf_unittests\": \"6d579a97c2c2dfeb787de1b27b3dcd9e8c4b1509\", \"perfetto_unittests\": \"3597817227397cb58da8e19e1e9e04a6f7070503\", \"ppapi_unittests\": \"fcbc41e37530d2c7ec6e354827b7b357ef7377e7\", \"printing_unittests\": \"d577373f77863a555910c9ea94c83ed2d2ca2275\", \"remoting_unittests\": \"b0cc3403c23ad4dbe4511f9c9f11a788d1f040e3\", \"sandbox_linux_unittests\": \"8014214c1fa4003adde563377c6e15d9f12cb534\", \"service_manager_unittests\": \"1660a11fcee1575775876390933cf53904e7ef21\", \"services_unittests\": \"c2f30493a0b81cf9555c3c7290e7b4aff9f04e82\", \"shell_dialogs_unittests\": \"0a05125d4ee6cce073ea68e64147809583bd2ad7\", \"skia_unittests\": \"e99659b909afd64f7e512da77d443cb48c704511\", \"snapshot_unittests\": \"f317a7a961e1fbf6fe7fb4f4423237fc3811c5c6\", \"sql_unittests\": \"f6ec6c1420e98d30f098e9a4f27b2319306ea460\", \"storage_unittests\": \"79d36655ba3cf919dd9de7f940ffab13bd62b6a3\", \"sync_integration_tests\": \"fe720bf830f0e726ac7c9b5ae3d3d6c96fb2b3ce\", \"telemetry_gpu_unittests\": \"cc856f78909d7345074eea37a03da67509658c63\", \"telemetry_perf_unittests\": \"91024402d1a933f46544d16a0dbdb2016cee1497\", \"telemetry_unittests\": \"6ce340f778e6cb989fd005894b6599df9892c8c9\", \"traffic_annotation_auditor_unittests\": \"e3a21e40095e66f62f00e92d2a691e2a878e3a36\", \"ui_base_unittests\": \"2acd601f45fe335b31a92a608ad2699809c0f7bc\", \"ui_touch_selection_unittests\": \"59d4b06be5c3cd675151a0f768dc7dc8ffd3018b\", \"unit_tests\": \"6a6c4d642f15c58a829844cffd5ffe56e0d81b1b\", \"url_unittests\": \"9ca98a8eee4dc46a55f762bc57d70a086f3ab3eb\", \"views_perftests\": \"64ad0ed6014396cbdfb7cb325aaa6820abc79efe\", \"views_unittests\": \"add9a318b7f18102f39f681e4ceb8822a50d95ea\", \"viz_unittests\": \"cd3cf536726f51933afa05f2cd4392101ad86345\", \"vr_common_unittests\": \"c4c9c054b41b227484d3893c81b6560aecb8f505\", \"vr_pixeltests\": \"1dc27c20475f17692fcacae4ba2f3b5bd2be3f18\", \"webdriver_wpt_tests\": \"163a8f4845a4b1dd4da21353732d67b871973593\", \"weblayer_browsertests\": \"dc2d794f253cf3e71b397fb2b8864010429e03c7\", \"wm_unittests\": \"4b0c827d3038ed70d092acde0aad16b82d6c7f85\", \"wtf_unittests\": \"7406182fd76522b96b52efa4329fedcf194c072e\", \"xr_browser_tests\": \"7966ccc9ef3677886a2a601dcd9b6944d534503c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_86caf262f74ae694bec00fbb86541daa2df96eb35c1a4d9a06c3c1dcd129237e_v2\", \"builder_9a2f1f8988f1f66ad7e537b613a307edd4200b924c9c36d38f851454b2c5979c_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_b91573fd5c97bdd1870d9c2b7f3dee6525147840030fe1e0975f137bcc8950b1_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-21-otjp\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4752-73c7603\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578734761671362",
"status": "COMPLETED",
"status_changed_ts": "1578738101712988",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167261",
"builder:Linux Builder (dbg)",
"buildset:commit/git/eb5c90d6340bfbdc8b24621fab16be4d97e343d5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb5c90d6340bfbdc8b24621fab16be4d97e343d5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057000669227275008",
"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/8891570607119857520/+/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:49acba4ad28d8510",
"user_agent:luci-scheduler"
],
"updated_ts": "1578738101723177",
"url": "https://ci.chromium.org/b/8891570607119857520",
"utcnow_ts": "1578738102579643"
}
}
[10:21:42.591] Invocation finished in 1h0m2.299462707s with status SUCCEEDED