[22:45:53.150] New invocation is queued and will start shortly
[22:45:55.364] Starting the invocation (attempt 1)
[22:45:55.419] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:45:55.420] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:45:55.420] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059849175382459088",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3aa67797606c73e38f6e10d3ffc8ce690cd1c20f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059849175382459088",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3aa67797606c73e38f6e10d3ffc8ce690cd1c20f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3aa67797606c73e38f6e10d3ffc8ce690cd1c20f",
"gitiles_ref:refs/heads/master"
]
}
[22:45:56.737] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576017955893274",
"id": "8894419111839969296",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3aa67797606c73e38f6e10d3ffc8ce690cd1c20f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576017956428778",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165920",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3aa67797606c73e38f6e10d3ffc8ce690cd1c20f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3aa67797606c73e38f6e10d3ffc8ce690cd1c20f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059849175382459088",
"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/8894419111839969296/+/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": "1576017956428919",
"url": "https://ci.chromium.org/b/8894419111839969296",
"utcnow_ts": "1576017956729378"
}
}
[22:45:56.737] Task URL: https://ci.chromium.org/b/8894419111839969296
[22:45:56.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:2:0) after 1m0s
[22:46:56.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:2:0)
[22:46:56.785] Timer tick, asking Buildbucket for the build status
[22:46:57.605] Build 8894419111839969296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:57.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:3:0) after 1m0s
[22:47:57.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:3:0)
[22:47:57.594] Timer tick, asking Buildbucket for the build status
[22:47:57.886] Build 8894419111839969296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:57.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:4:0) after 1m0s
[22:48:57.944] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:4:0)
[22:48:57.944] Timer tick, asking Buildbucket for the build status
[22:48:58.336] Build 8894419111839969296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:58.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:5:0) after 1m0s
[22:49:58.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:5:0)
[22:49:58.418] Timer tick, asking Buildbucket for the build status
[22:49:58.886] Build 8894419111839969296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:58.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:6:0) after 1m0s
[22:50:59.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:6:0)
[22:50:59.047] Timer tick, asking Buildbucket for the build status
[22:50:59.743] Build 8894419111839969296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:59.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:7:0) after 1m0s
[22:51:07.421] Received PubSub notification, asking Buildbucket for the build status
[22:51:08.797] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:59.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:7:0)
[22:51:59.870] Timer tick, asking Buildbucket for the build status
[22:52:00.288] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:9:0) after 1m0s
[22:53:00.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:9:0)
[22:53:00.354] Timer tick, asking Buildbucket for the build status
[22:53:01.455] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:01.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:10:0) after 1m0s
[22:54:01.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:10:0)
[22:54:01.554] Timer tick, asking Buildbucket for the build status
[22:54:01.772] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:01.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:11:0) after 1m0s
[22:55:01.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:11:0)
[22:55:01.810] Timer tick, asking Buildbucket for the build status
[22:55:01.989] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:01.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:12:0) after 1m0s
[22:56:02.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:12:0)
[22:56:02.112] Timer tick, asking Buildbucket for the build status
[22:56:02.650] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:02.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:13:0) after 1m0s
[22:57:02.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:13:0)
[22:57:02.752] Timer tick, asking Buildbucket for the build status
[22:57:02.959] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:02.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:14:0) after 1m0s
[22:58:03.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:14:0)
[22:58:03.082] Timer tick, asking Buildbucket for the build status
[22:58:03.264] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:03.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:15:0) after 1m0s
[22:59:03.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:15:0)
[22:59:03.490] Timer tick, asking Buildbucket for the build status
[22:59:03.842] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:03.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:16:0) after 1m0s
[23:00:03.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:16:0)
[23:00:03.968] Timer tick, asking Buildbucket for the build status
[23:00:04.262] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:04.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:17:0) after 1m0s
[23:01:04.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:17:0)
[23:01:04.308] Timer tick, asking Buildbucket for the build status
[23:01:04.697] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:04.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:18:0) after 1m0s
[23:02:05.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:18:0)
[23:02:05.095] Timer tick, asking Buildbucket for the build status
[23:02:05.869] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:05.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:19:0) after 1m0s
[23:03:06.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:19:0)
[23:03:06.138] Timer tick, asking Buildbucket for the build status
[23:03:06.426] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:06.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:20:0) after 1m0s
[23:04:06.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:20:0)
[23:04:06.790] Timer tick, asking Buildbucket for the build status
[23:04:07.791] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:07.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:21:0) after 1m0s
[23:05:07.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:21:0)
[23:05:07.882] Timer tick, asking Buildbucket for the build status
[23:05:08.752] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:08.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:22:0) after 1m0s
[23:06:08.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:22:0)
[23:06:08.991] Timer tick, asking Buildbucket for the build status
[23:06:09.502] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:09.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:23:0) after 1m0s
[23:07:09.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:23:0)
[23:07:09.665] Timer tick, asking Buildbucket for the build status
[23:07:10.239] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:10.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:24:0) after 1m0s
[23:08:10.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:24:0)
[23:08:10.318] Timer tick, asking Buildbucket for the build status
[23:08:11.335] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:11.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:25:0) after 1m0s
[23:09:11.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:25:0)
[23:09:11.442] Timer tick, asking Buildbucket for the build status
[23:09:13.752] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:13.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:26:0) after 1m0s
[23:10:13.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:26:0)
[23:10:13.916] Timer tick, asking Buildbucket for the build status
[23:10:14.205] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:14.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:27:0) after 1m0s
[23:11:14.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:27:0)
[23:11:14.378] Timer tick, asking Buildbucket for the build status
[23:11:14.673] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:14.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:28:0) after 1m0s
[23:12:15.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:28:0)
[23:12:15.027] Timer tick, asking Buildbucket for the build status
[23:12:15.872] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:15.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:29:0) after 1m0s
[23:13:16.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:29:0)
[23:13:16.028] Timer tick, asking Buildbucket for the build status
[23:13:16.486] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:16.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:30:0) after 1m0s
[23:14:16.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:30:0)
[23:14:16.534] Timer tick, asking Buildbucket for the build status
[23:14:17.085] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:17.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:31:0) after 1m0s
[23:15:17.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:31:0)
[23:15:17.277] Timer tick, asking Buildbucket for the build status
[23:15:17.441] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:17.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:32:0) after 1m0s
[23:16:17.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:32:0)
[23:16:17.712] Timer tick, asking Buildbucket for the build status
[23:16:18.332] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:18.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:33:0) after 1m0s
[23:17:18.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:33:0)
[23:17:18.470] Timer tick, asking Buildbucket for the build status
[23:17:18.752] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:18.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:34:0) after 1m0s
[23:18:18.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:34:0)
[23:18:18.790] Timer tick, asking Buildbucket for the build status
[23:18:19.426] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:19.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:35:0) after 1m0s
[23:19:19.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:35:0)
[23:19:19.481] Timer tick, asking Buildbucket for the build status
[23:19:20.083] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:20.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:36:0) after 1m0s
[23:20:20.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:36:0)
[23:20:20.165] Timer tick, asking Buildbucket for the build status
[23:20:21.270] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:21.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:37:0) after 1m0s
[23:21:21.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:37:0)
[23:21:21.315] Timer tick, asking Buildbucket for the build status
[23:21:21.669] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:21.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:38:0) after 1m0s
[23:22:21.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:38:0)
[23:22:21.690] Timer tick, asking Buildbucket for the build status
[23:22:21.926] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:21.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:39:0) after 1m0s
[23:23:22.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:39:0)
[23:23:22.038] Timer tick, asking Buildbucket for the build status
[23:23:22.222] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:22.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:40:0) after 1m0s
[23:24:22.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:40:0)
[23:24:22.414] Timer tick, asking Buildbucket for the build status
[23:24:22.987] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:22.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:41:0) after 1m0s
[23:25:23.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:41:0)
[23:25:23.069] Timer tick, asking Buildbucket for the build status
[23:25:23.338] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:23.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:42:0) after 1m0s
[23:26:24.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:42:0)
[23:26:24.609] Timer tick, asking Buildbucket for the build status
[23:26:24.806] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:24.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:43:0) after 1m0s
[23:27:25.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:43:0)
[23:27:25.518] Timer tick, asking Buildbucket for the build status
[23:27:26.058] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:26.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:44:0) after 1m0s
[23:28:26.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:44:0)
[23:28:26.328] Timer tick, asking Buildbucket for the build status
[23:28:27.008] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:27.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:45:0) after 1m0s
[23:29:27.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:45:0)
[23:29:27.100] Timer tick, asking Buildbucket for the build status
[23:29:27.984] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:27.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:46:0) after 1m0s
[23:30:28.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:46:0)
[23:30:28.141] Timer tick, asking Buildbucket for the build status
[23:30:28.283] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:28.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:47:0) after 1m0s
[23:31:28.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:47:0)
[23:31:28.346] Timer tick, asking Buildbucket for the build status
[23:31:29.073] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:29.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:48:0) after 1m0s
[23:32:29.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:48:0)
[23:32:29.177] Timer tick, asking Buildbucket for the build status
[23:32:29.733] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:29.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:49:0) after 1m0s
[23:33:29.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:49:0)
[23:33:29.912] Timer tick, asking Buildbucket for the build status
[23:33:30.588] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:30.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:50:0) after 1m0s
[23:34:30.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:50:0)
[23:34:30.682] Timer tick, asking Buildbucket for the build status
[23:34:30.906] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:30.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:51:0) after 1m0s
[23:35:31.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:51:0)
[23:35:31.057] Timer tick, asking Buildbucket for the build status
[23:35:32.908] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:32.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:52:0) after 1m0s
[23:36:33.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:52:0)
[23:36:33.127] Timer tick, asking Buildbucket for the build status
[23:36:34.619] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:34.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:53:0) after 1m0s
[23:37:34.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:53:0)
[23:37:34.990] Timer tick, asking Buildbucket for the build status
[23:37:36.176] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:36.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:54:0) after 1m0s
[23:38:36.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:54:0)
[23:38:36.609] Timer tick, asking Buildbucket for the build status
[23:38:36.796] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:36.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:55:0) after 1m0s
[23:39:36.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:55:0)
[23:39:36.829] Timer tick, asking Buildbucket for the build status
[23:39:37.135] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:37.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:56:0) after 1m0s
[23:40:37.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:56:0)
[23:40:37.287] Timer tick, asking Buildbucket for the build status
[23:40:37.579] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:37.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:57:0) after 1m0s
[23:41:37.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:57:0)
[23:41:37.702] Timer tick, asking Buildbucket for the build status
[23:41:38.406] Build 8894419111839969296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:38.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059849175382459088:58:0) after 1m0s
[23:41:56.613] Received PubSub notification, asking Buildbucket for the build status
[23:41:56.953] Build 8894419111839969296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:41:56.953] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576021315467491",
"created_by": "project:chromium",
"created_ts": "1576017955893274",
"id": "8894419111839969296",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3aa67797606c73e38f6e10d3ffc8ce690cd1c20f\"}}",
"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-98-hawv\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165920, \"got_angle_revision\": \"351307eba33211be31cd1c6ea78ab23be8665f1e\", \"got_dawn_revision\": \"f15fc26d5bf5d71f342eb44109a201aa59ad1e8c\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3aa67797606c73e38f6e10d3ffc8ce690cd1c20f\", \"got_revision_cp\": \"refs/heads/master@{#723557}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"8ed7ae4c8e9bf38ad0ff3bdee11dd0d7e46d0e7f\", \"got_v8_revision\": \"a7b3b5faf0c910eb2421d9386bcce32de672ba97\", \"got_v8_revision_cp\": \"refs/heads/8.1.12@{#1}\", \"got_webrtc_revision\": \"947a380b81ecd3eb40af30f317e3ccef521d5574\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30056}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3aa67797606c73e38f6e10d3ffc8ce690cd1c20f\", \"swarm_hashes_refs/heads/master(at){#723557}_without_patch\": {\"accessibility_unittests\": \"5ecd2fdedce292107071894c83a10524cdd620f9\", \"angle_unittests\": \"9ed278b8a73329f38324e83191c001130adf5138\", \"app_shell_unittests\": \"f44eac4041014d2200638fdad3e4420f2fd4d648\", \"aura_unittests\": \"591be73b7e9fdc760377890276a44e114c523d7c\", \"base_unittests\": \"f699ebfb0347de1c51c8ced60321fc5178658401\", \"base_util_unittests\": \"6bf9824b65559a5e3c1ee086b084ac86c4cf0960\", \"blink_common_unittests\": \"f1dba05b3d3d6de1690c359002f1b26787228fe0\", \"blink_fuzzer_unittests\": \"dc5f57be4b2b95edda2f1766b5fffdb43110c8bb\", \"blink_heap_unittests\": \"662c098b547da1d86548374019c68b10eabe4c85\", \"blink_platform_unittests\": \"3d64b6b7e25c593cc0625e02baa0f1ab55a7d89d\", \"blink_python_tests\": \"1dc4edcb976e617acd970affcba95e06127d60d5\", \"blink_unittests\": \"8e5b08a9c418ebc2245c4320c4ef79f82e32e5ac\", \"blink_web_tests\": \"3f9becca66342646aed5acff8461e1440dddc8ad\", \"boringssl_crypto_tests\": \"2718b71f4a67c8e94a6dd1e8dc2e60599b2e241c\", \"boringssl_ssl_tests\": \"dd3f4445c5fa16ef7e315d0f4bf8317135dabb5d\", \"browser_tests\": \"41f3863bbaa52d6523f61a5ab56bc703766f9c6f\", \"cacheinvalidation_unittests\": \"0fabada1bd23bf921f872fd17e6471cdd14011cb\", \"capture_unittests\": \"98034767d2c49132eaa05ad70a6b632b9b2c7599\", \"cast_unittests\": \"d2c1377eab5b3dc585717d26de13489af5f0bf57\", \"cc_unittests\": \"daf281eea253c35fd712fcd9e9b872d6990d642c\", \"chrome_app_unittests\": \"a9fbf6f15cb2f6a0aac946e428ca87a0b69513f5\", \"chromedriver_unittests\": \"030c441e2f79bf3e5403ddd84a6cb5c5e3b624a0\", \"components_browsertests\": \"20d1d6de2db1b4ad57a511173c00918498d5019d\", \"components_unittests\": \"7fc37ea4d8141804e7b442a90251081e86d0da93\", \"compositor_unittests\": \"70823a54bf7ea3f9084711b94cc93d1b64b49cde\", \"content_browsertests\": \"aacaae2c6b73273b26c041ba2a96dd49d179da3b\", \"content_shell_crash_test\": \"d329c3cfe873fb0a25f0ca0a2dee98c4e17d879f\", \"content_unittests\": \"0ca4dd7afb112ecafc3571d159e9a26b68c802e8\", \"crashpad_tests\": \"80af57f6623b768db9a7abd312a95f202dfbf3ef\", \"cronet_tests\": \"96daaf2997e106419017d75bb7150f9f574edb59\", \"cronet_unittests\": \"f17d5f087229f1fb5efbb0f0b3e3306b2e2377b7\", \"crypto_unittests\": \"4b816e27349ce4fe53ec3b788c33d64b71b495a0\", \"dbus_unittests\": \"a6906aafe34d7158983c773d6c517ad74b401151\", \"device_unittests\": \"9f60717e449270612e5195ead03279757169eaa4\", \"devtools_lint_check\": \"a051b2d22eace6515b3043351536095487cf22ec\", \"devtools_type_check\": \"f7b71a790c163265fbaa0f1b27bf107e76f0a8e0\", \"display_unittests\": \"93219e22b8e57b3f1a592998fe45f592b865a085\", \"events_unittests\": \"d908c051df76682df7fa97d293d5173511f0dc6b\", \"extensions_browsertests\": \"37e7f01881122abd7c6e540d581bfdbf5d38ad9b\", \"extensions_unittests\": \"949c6dfc995e31f62d5094fa46b38d0822911a7b\", \"filesystem_service_unittests\": \"eb5c328bfe118a14b8113d929965c9df6c2fb4a6\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"32d7611dcf550c733f8dee44da7e91e104a4e99c\", \"gfx_unittests\": \"7c83094258bffaa263ef17c8f00845b1c8d2206f\", \"gin_unittests\": \"544c5c713b1186ddec3e1992e5ace0b869061f17\", \"google_apis_unittests\": \"4461c51adc5eb350040f8a956ecd1ec80ca6ae6f\", \"gpu_unittests\": \"df78e1727a2ffd9c1bf47ba054ad5eb11d54089d\", \"grit_python_unittests\": \"e57825f6dc47aecc895f8acb8b5f5fd25b3001dd\", \"gwp_asan_unittests\": \"acb424e8c48e6babdca6d983a39aeeb40c5fdaa8\", \"headless_browsertests\": \"c94fd013cb0bed3270414878ee764dff479d9d9a\", \"headless_unittests\": \"1637917d1ba610711b13be9c538348f3574dedff\", \"interactive_ui_tests\": \"e390fa43eabbec1659952f8200881ef35650776e\", \"ipc_tests\": \"36640e2348722ea4b30ae059b3354d7acf0030f8\", \"jingle_unittests\": \"ed8c8d753f6e6c8b7ef646f3dec6bf242cf81828\", \"latency_unittests\": \"5ce587e8b1b7ec7aec34366c13d4ae22a79bdd72\", \"libjingle_xmpp_unittests\": \"6b3340b232c99396d9e1e17f9f00d7a1460f02b4\", \"media_blink_unittests\": \"d680b97150fd9c0870237905fcd7926dd6092910\", \"media_service_unittests\": \"3ac3bc399ba34b1b505ebdfc8a152b87905e300e\", \"media_unittests\": \"4cf662a2862175f48b6a3de5a256dc46f2637f9b\", \"message_center_unittests\": \"4b939d193fcb22932e9133c24b1707488599f08a\", \"metrics_python_tests\": \"9fe8500e1024de4d52036932b8b3837d3e7b35e7\", \"midi_unittests\": \"a72878301ca0ebcb7de08f5793d218885a7c40f4\", \"mojo_core_unittests\": \"406bc2a0b6df151d5878664b7a679a3c14a87fee\", \"mojo_unittests\": \"448c7b65840ef070255e84002c781a41417f5071\", \"nacl_helper_nonsfi_unittests\": \"76b3ef913f787b77177681354f09c56f0665f483\", \"nacl_loader_unittests\": \"61e1ba2ef051acd3e2d834bb481c90736a4d3049\", \"native_theme_unittests\": \"2f3a4454be85825d64637233862c137d219fc462\", \"net_unittests\": \"81300927635ec1a6f6a953315199919a84c0e140\", \"pdf_unittests\": \"f64a3561012f102bb431e37bc3f10a7ad77fc4cc\", \"perfetto_unittests\": \"a118de110fa55ec6ebcf8bc7326d394219be3f6a\", \"ppapi_unittests\": \"74e60b6943ebf7f98d9d30362bd22555970e8772\", \"printing_unittests\": \"f258a8a0a9caef5acbb3efa686145d0f7aa0c0d1\", \"remoting_unittests\": \"0532ac53ba69268bbca6b7fd097241c8ec8f231b\", \"sandbox_linux_unittests\": \"5d2613b8bde7d5aa7747467beeeba4bd73a0b2df\", \"service_manager_unittests\": \"03447688bbae79a85b7298ff1c1d408b2f8a5a7d\", \"services_unittests\": \"a3169a485451952d64111e5bb0c83e4bf2853e3b\", \"shell_dialogs_unittests\": \"a96e3b022245270ab4781ab9315cfe528d740b3b\", \"skia_unittests\": \"bade7516b4ad19fb9ee4b57075ddf8580ed4ded2\", \"snapshot_unittests\": \"aebb09319f9c83b775250de9373eba46a8cbfb28\", \"sql_unittests\": \"0a17edc89b965a2221282fe616cdfea48ddd716f\", \"storage_unittests\": \"e57c795c3f1c7e0bdb978715f0d83956744414c4\", \"sync_integration_tests\": \"51dbcdd694e5bb456f5e619b2f0f6460d5f242b4\", \"telemetry_gpu_unittests\": \"c17dd28e7e37917959d42a17a19f0865f3bbb73e\", \"telemetry_perf_unittests\": \"0359c8cf4cb7b128b17cf2161f7ac44a6ed0315e\", \"telemetry_unittests\": \"54d7a119cd9e6921ce21da77c5ae9ddb09c8f487\", \"traffic_annotation_auditor_unittests\": \"da9559e6c9b2bd31571a824d49636732cd8a5566\", \"ui_base_unittests\": \"b648677c96165808add943212c849fc2b6437b21\", \"ui_touch_selection_unittests\": \"997d0250c60d859647f1ae741cb88b5e3301ebcb\", \"unit_tests\": \"8206327a074324fe77f72723872be01ea6112a73\", \"url_unittests\": \"c8fcf519e150d1c514f7871a05eae97d0996d5ef\", \"views_perftests\": \"8a4f4e644d44ad3b157f6973096d48c511490bf6\", \"views_unittests\": \"8865d0c7f75d2501e1e9879195dc30a7afb8cecc\", \"viz_unittests\": \"d52c812836305a0473244f5f043d9298b3d6a458\", \"vr_common_unittests\": \"89040a021222378a0c1cfeeb8eba8a4be927941e\", \"vr_pixeltests\": \"126ced70d4d32b4a5eb64308ea8896f8b27e1b46\", \"webdriver_wpt_tests\": \"2d098ae5e8a390f208eb52a09a608b98d52acac8\", \"weblayer_browsertests\": \"1b787dbabb64ec419387108ab19bc7bf8d1e6051\", \"wm_unittests\": \"c98196268fb69733735c21f42bfeaf297878ec80\", \"wtf_unittests\": \"27adaf19fe3f9c70986210f5f70a8a095201c4e4\", \"xr_browser_tests\": \"60be8b22d9afc5de1316e7762ff814d0a66cac9a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_497278b5819f10111ab639898a894ad19d361b24d185228ca986cf767de7a7ef_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-98-hawv\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4709-f2c88b6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576018266521501",
"status": "COMPLETED",
"status_changed_ts": "1576021315958209",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165920",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3aa67797606c73e38f6e10d3ffc8ce690cd1c20f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3aa67797606c73e38f6e10d3ffc8ce690cd1c20f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059849175382459088",
"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/8894419111839969296/+/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:490acf639c850710",
"user_agent:luci-scheduler"
],
"updated_ts": "1576021315979939",
"url": "https://ci.chromium.org/b/8894419111839969296",
"utcnow_ts": "1576021316933817"
}
}
[23:41:56.953] Invocation finished in 56m3.821818719s with status SUCCEEDED