[04:53:16.142] New invocation is queued and will start shortly
[04:53:17.222] Starting the invocation (attempt 1)
[04:53:17.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:53:17.257] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:53:17.257] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054752631511536624",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"05e3ba69aa1bd35c8e96a260e7b545675043599a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054752631511536624",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/05e3ba69aa1bd35c8e96a260e7b545675043599a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05e3ba69aa1bd35c8e96a260e7b545675043599a",
"gitiles_ref:refs/heads/master"
]
}
[04:53:18.380] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1580878397427212",
"id": "8889322569497550432",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05e3ba69aa1bd35c8e96a260e7b545675043599a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580878398084727",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168241",
"builder:Linux Builder (dbg)",
"buildset:commit/git/05e3ba69aa1bd35c8e96a260e7b545675043599a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05e3ba69aa1bd35c8e96a260e7b545675043599a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054752631511536624",
"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/8889322569497550432/+/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": "1580878398085554",
"url": "https://ci.chromium.org/b/8889322569497550432",
"utcnow_ts": "1580878398365513"
}
}
[04:53:18.380] Task URL: https://ci.chromium.org/b/8889322569497550432
[04:53:18.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:2:0) after 1m0s
[04:54:18.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:2:0)
[04:54:18.462] Timer tick, asking Buildbucket for the build status
[04:54:18.626] Build 8889322569497550432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:18.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:3:0) after 1m0s
[04:55:18.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:3:0)
[04:55:18.659] Timer tick, asking Buildbucket for the build status
[04:55:19.296] Build 8889322569497550432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:19.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:4:0) after 1m0s
[04:56:19.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:4:0)
[04:56:19.321] Timer tick, asking Buildbucket for the build status
[04:56:19.820] Build 8889322569497550432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:19.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:5:0) after 1m0s
[04:57:19.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:5:0)
[04:57:19.870] Timer tick, asking Buildbucket for the build status
[04:57:20.344] Build 8889322569497550432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:20.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:6:0) after 1m0s
[04:58:04.163] Received PubSub notification, asking Buildbucket for the build status
[04:58:04.497] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:20.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:6:0)
[04:58:20.397] Timer tick, asking Buildbucket for the build status
[04:58:21.821] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:21.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:8:0) after 1m0s
[04:59:21.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:8:0)
[04:59:21.876] Timer tick, asking Buildbucket for the build status
[04:59:22.029] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:22.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:9:0) after 1m0s
[05:00:22.151] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:9:0)
[05:00:22.151] Timer tick, asking Buildbucket for the build status
[05:00:23.607] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:23.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:10:0) after 1m0s
[05:01:23.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:10:0)
[05:01:23.648] Timer tick, asking Buildbucket for the build status
[05:01:24.320] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:24.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:11:0) after 1m0s
[05:02:24.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:11:0)
[05:02:24.438] Timer tick, asking Buildbucket for the build status
[05:02:27.735] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:27.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:12:0) after 1m0s
[05:03:27.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:12:0)
[05:03:27.793] Timer tick, asking Buildbucket for the build status
[05:03:27.945] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:27.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:13:0) after 1m0s
[05:04:28.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:13:0)
[05:04:28.035] Timer tick, asking Buildbucket for the build status
[05:04:28.229] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:28.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:14:0) after 1m0s
[05:05:28.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:14:0)
[05:05:28.349] Timer tick, asking Buildbucket for the build status
[05:05:28.567] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:28.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:15:0) after 1m0s
[05:06:28.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:15:0)
[05:06:28.660] Timer tick, asking Buildbucket for the build status
[05:06:28.863] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:28.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:16:0) after 1m0s
[05:07:28.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:16:0)
[05:07:28.901] Timer tick, asking Buildbucket for the build status
[05:07:29.306] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:29.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:17:0) after 1m0s
[05:08:29.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:17:0)
[05:08:29.326] Timer tick, asking Buildbucket for the build status
[05:08:29.758] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:29.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:18:0) after 1m0s
[05:09:29.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:18:0)
[05:09:29.789] Timer tick, asking Buildbucket for the build status
[05:09:30.068] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:30.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:19:0) after 1m0s
[05:10:30.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:19:0)
[05:10:30.281] Timer tick, asking Buildbucket for the build status
[05:10:30.507] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:30.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:20:0) after 1m0s
[05:11:30.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:20:0)
[05:11:30.628] Timer tick, asking Buildbucket for the build status
[05:11:31.528] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:31.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:21:0) after 1m0s
[05:12:31.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:21:0)
[05:12:31.622] Timer tick, asking Buildbucket for the build status
[05:12:31.793] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:31.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:22:0) after 1m0s
[05:13:31.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:22:0)
[05:13:31.840] Timer tick, asking Buildbucket for the build status
[05:13:32.227] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:32.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:23:0) after 1m0s
[05:14:32.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:23:0)
[05:14:32.253] Timer tick, asking Buildbucket for the build status
[05:14:32.853] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:32.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:24:0) after 1m0s
[05:15:32.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:24:0)
[05:15:32.884] Timer tick, asking Buildbucket for the build status
[05:15:34.262] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:34.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:25:0) after 1m0s
[05:16:34.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:25:0)
[05:16:34.387] Timer tick, asking Buildbucket for the build status
[05:16:35.018] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:26:0) after 1m0s
[05:17:35.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:26:0)
[05:17:35.079] Timer tick, asking Buildbucket for the build status
[05:17:35.236] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:35.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:27:0) after 1m0s
[05:18:35.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:27:0)
[05:18:35.406] Timer tick, asking Buildbucket for the build status
[05:18:35.582] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:35.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:28:0) after 1m0s
[05:19:35.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:28:0)
[05:19:35.672] Timer tick, asking Buildbucket for the build status
[05:19:36.149] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:36.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:29:0) after 1m0s
[05:20:36.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:29:0)
[05:20:36.213] Timer tick, asking Buildbucket for the build status
[05:20:36.490] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:36.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:30:0) after 1m0s
[05:21:36.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:30:0)
[05:21:36.576] Timer tick, asking Buildbucket for the build status
[05:21:36.726] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:36.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:31:0) after 1m0s
[05:22:36.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:31:0)
[05:22:36.837] Timer tick, asking Buildbucket for the build status
[05:22:37.229] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:37.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:32:0) after 1m0s
[05:23:37.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:32:0)
[05:23:37.334] Timer tick, asking Buildbucket for the build status
[05:23:38.075] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:38.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:33:0) after 1m0s
[05:24:38.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:33:0)
[05:24:38.159] Timer tick, asking Buildbucket for the build status
[05:24:38.363] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:38.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:34:0) after 1m0s
[05:25:38.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:34:0)
[05:25:38.433] Timer tick, asking Buildbucket for the build status
[05:25:39.049] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:39.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:35:0) after 1m0s
[05:26:39.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:35:0)
[05:26:39.132] Timer tick, asking Buildbucket for the build status
[05:26:39.512] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:39.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:36:0) after 1m0s
[05:27:39.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:36:0)
[05:27:39.530] Timer tick, asking Buildbucket for the build status
[05:27:39.732] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:39.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:37:0) after 1m0s
[05:28:39.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:37:0)
[05:28:39.794] Timer tick, asking Buildbucket for the build status
[05:28:39.970] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:39.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:38:0) after 1m0s
[05:29:39.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:38:0)
[05:29:39.990] Timer tick, asking Buildbucket for the build status
[05:29:40.376] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:40.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:39:0) after 1m0s
[05:30:40.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:39:0)
[05:30:40.538] Timer tick, asking Buildbucket for the build status
[05:30:40.799] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:40.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:40:0) after 1m0s
[05:31:40.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:40:0)
[05:31:40.863] Timer tick, asking Buildbucket for the build status
[05:31:41.476] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:41.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:41:0) after 1m0s
[05:32:41.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:41:0)
[05:32:41.549] Timer tick, asking Buildbucket for the build status
[05:32:41.750] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:41.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:42:0) after 1m0s
[05:33:41.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:42:0)
[05:33:41.907] Timer tick, asking Buildbucket for the build status
[05:33:42.622] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:42.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:43:0) after 1m0s
[05:34:42.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:43:0)
[05:34:42.705] Timer tick, asking Buildbucket for the build status
[05:34:42.887] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:42.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:44:0) after 1m0s
[05:35:42.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:44:0)
[05:35:42.957] Timer tick, asking Buildbucket for the build status
[05:35:43.164] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:43.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:45:0) after 1m0s
[05:36:43.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:45:0)
[05:36:43.209] Timer tick, asking Buildbucket for the build status
[05:36:43.359] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:43.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:46:0) after 1m0s
[05:37:43.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:46:0)
[05:37:43.382] Timer tick, asking Buildbucket for the build status
[05:37:43.552] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:43.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:47:0) after 1m0s
[05:38:43.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:47:0)
[05:38:43.592] Timer tick, asking Buildbucket for the build status
[05:38:44.138] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:44.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:48:0) after 1m0s
[05:39:44.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:48:0)
[05:39:44.169] Timer tick, asking Buildbucket for the build status
[05:39:44.845] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:44.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:49:0) after 1m0s
[05:40:44.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:49:0)
[05:40:44.863] Timer tick, asking Buildbucket for the build status
[05:40:45.210] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:45.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:50:0) after 1m0s
[05:41:45.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:50:0)
[05:41:45.210] Timer tick, asking Buildbucket for the build status
[05:41:45.439] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:45.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:51:0) after 1m0s
[05:42:45.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:51:0)
[05:42:45.496] Timer tick, asking Buildbucket for the build status
[05:42:45.779] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:45.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:52:0) after 1m0s
[05:43:45.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:52:0)
[05:43:45.801] Timer tick, asking Buildbucket for the build status
[05:43:45.936] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:45.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:53:0) after 1m0s
[05:44:46.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:53:0)
[05:44:46.052] Timer tick, asking Buildbucket for the build status
[05:44:46.975] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:46.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:54:0) after 1m0s
[05:45:47.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:54:0)
[05:45:47.080] Timer tick, asking Buildbucket for the build status
[05:45:47.952] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:47.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:55:0) after 1m0s
[05:46:48.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:55:0)
[05:46:48.136] Timer tick, asking Buildbucket for the build status
[05:46:48.319] Build 8889322569497550432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:48.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054752631511536624:56:0) after 1m0s
[05:47:01.552] Received PubSub notification, asking Buildbucket for the build status
[05:47:02.531] Build 8889322569497550432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:47:02.531] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1580881620627159",
"created_by": "project:chromium",
"created_ts": "1580878397427212",
"id": "8889322569497550432",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05e3ba69aa1bd35c8e96a260e7b545675043599a\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-128-133x\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168241, \"got_angle_revision\": \"d8c4b5fb80d417343b52273515e046a37eda7138\", \"got_dawn_revision\": \"47b15048a1fab6c360dc1594764506224655752b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"05e3ba69aa1bd35c8e96a260e7b545675043599a\", \"got_revision_cp\": \"refs/heads/master@{#738437}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"59a29e3c4f030bc4a835a8cb8ebdefaa1f58b74d\", \"got_v8_revision\": \"4460b2d2f5aa0f77cfd10a6c2301a95ad08aa9a5\", \"got_v8_revision_cp\": \"refs/heads/8.2.8@{#1}\", \"got_webrtc_revision\": \"0f6bcd18b2ef109850c6430fa0d474688571da5f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30455}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05e3ba69aa1bd35c8e96a260e7b545675043599a\", \"swarm_hashes_refs/heads/master(at){#738437}_without_patch\": {\"accessibility_unittests\": \"e5000f2dd2351a53f96ad1126aa636993209f7b4\", \"angle_unittests\": \"b6267a6088aa32cef9cdb7abbaf881e03095fe8c\", \"app_shell_unittests\": \"d585e64c6f1e3906c0e28428d2af8203f643cd7d\", \"aura_unittests\": \"921a6b4438acc74cbb3635534430dec57927b10f\", \"base_unittests\": \"a29af277288587a8797dfa0db01345b3d8a9f959\", \"base_util_unittests\": \"8818a9773a30bd7c33cdec37a93518b2382f934c\", \"blink_common_unittests\": \"c0c95664ca1175ade04beb1be29a8f5289f87d35\", \"blink_fuzzer_unittests\": \"23b47cb5a688b3511bfab26751172175f20d8acb\", \"blink_heap_unittests\": \"f2bb182bcd09f6755d7845437e6bcc94460dfe65\", \"blink_platform_unittests\": \"98fec92c520467dd45711fde39f536480d9cefd6\", \"blink_python_tests\": \"e86d8b946708b0a1ad9435aa64cf56ca4299e987\", \"blink_unittests\": \"021ff12422589db04b359f2582245ccee3e292e5\", \"blink_web_tests\": \"eeee1daa2659daaaa788614e097f417cc75d4017\", \"boringssl_crypto_tests\": \"647acdbbf37dcb1c568c903868bcd7d855eb8d3d\", \"boringssl_ssl_tests\": \"2d20c1e4e0accd9c244ab60965347348f2ba0707\", \"browser_tests\": \"ac16a4929142f2cf38b0d90557192311d0d86ca8\", \"cacheinvalidation_unittests\": \"fb78258f28fc3710799ce5f9fc563eff7a407fe6\", \"capture_unittests\": \"5d4b5855bfb74cdf2e1fdc3cd52e8bfd9ea6d5dd\", \"cast_unittests\": \"10740930d58518e35f32424f126ee877678b1972\", \"cc_unittests\": \"45ce5832c42fff9ca1b858936bb52b3590479cfc\", \"chrome_app_unittests\": \"bcc09c4e6eab2176241b128b40dfa78b4570e3fa\", \"chromedriver_unittests\": \"3872f1d7023a7d3b952965ccc201e538cb8e856c\", \"components_browsertests\": \"4bdc6dbe78d8ec126343bb3aed062eae860a93d9\", \"components_unittests\": \"466245e219d8dd106c6065f1ce676957fa7534d2\", \"compositor_unittests\": \"1009730b76304c6bc74a9f19c2b2a64041234689\", \"content_browsertests\": \"6187f65016f2603bc0514d8c4fda89424c6ed873\", \"content_shell_crash_test\": \"fc1b9c5d5228b7935b2ee6536ee14b6dd14454a6\", \"content_unittests\": \"129975fce43d56d13d421332332b3c57cb15228f\", \"crashpad_tests\": \"0af122a680e0eff26626a05740cfdd0e49ba9701\", \"cronet_tests\": \"dfb9eaa98fc1cbe273413cab6ca3f630decadafb\", \"cronet_unittests\": \"f93927b268ede1f44954e99138ab3939bd7d5434\", \"crypto_unittests\": \"71311b088be815360ef6cc6ea5930edb34e2864b\", \"dbus_unittests\": \"873e817e19dbdc5f49bf65aaf57c76570748dbc7\", \"device_unittests\": \"1e4ba6c3832cb4ee8929719abf040fc3a183a333\", \"display_unittests\": \"d00ecbe6f61f19df1d08e9cf6294ebe7c2b33322\", \"events_unittests\": \"f2f153e56ae33cffb9215a58a1a1753d22608df1\", \"extensions_browsertests\": \"61515e9112d0181af51ce97d72ec87ea5221cc7b\", \"extensions_unittests\": \"f0f62f3f1c43f63dc48d2ecc91c80a0e3aa2dd00\", \"filesystem_service_unittests\": \"1a2b869b7c50c54220c88837f04505704757b5d1\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"2985463df3ca830839db8d0f7a3961fb55eb9d10\", \"gfx_unittests\": \"0eaa30094c89101a3630b1aee1a86ad955c9b6a6\", \"gin_unittests\": \"c61de02267715647bd180f3f4569bee0096ef33c\", \"google_apis_unittests\": \"8a0ffa58f11ca33900c469d9aed1972fc3ad911c\", \"gpu_unittests\": \"2147efda634732936eb64bdb17fe32f9ac4aab53\", \"grit_python_unittests\": \"a906de1211aa1e6d0b6deb8a9a162d6998fb6336\", \"gwp_asan_unittests\": \"d2d57150bbed91c14f6cd4b17df0b9b078449849\", \"headless_browsertests\": \"f293f9b2cf7a949d38dd73727d874c7bb7b062c9\", \"headless_unittests\": \"72e44edb30fb60fa6911a5eff240ffb07e23c46a\", \"interactive_ui_tests\": \"233fe7be09b4c6cfc7e6bb0f88282072022ac7be\", \"ipc_tests\": \"fb427930799318586b065f07ec92e203a6ee8772\", \"jingle_unittests\": \"a8841f5051a3b197fd438b7104a7bc10db0d13c2\", \"latency_unittests\": \"bd3906f186130b37cb0bfd0a5d068f4f2bc2efc5\", \"libjingle_xmpp_unittests\": \"30e8f4801d30ee5339e5d67549d426f26b9b7e6b\", \"media_blink_unittests\": \"4f43bb48530d7a043e6bce7d86d728d172f1860d\", \"media_service_unittests\": \"b344a44fd71bd371296e66e0f6c158cd8ccb42ea\", \"media_unittests\": \"108a6bfcbf2867b3a3f3c6db1beeab60bd10c6c3\", \"message_center_unittests\": \"341fc425d93b78d717e1c09a7e642250b6592fcc\", \"metrics_python_tests\": \"5421ca83b2d12693642dbe0f02ce6a6873cea612\", \"midi_unittests\": \"dd9fc8c0530a150cc97eff2763a3e6aa65fc459a\", \"mojo_core_unittests\": \"cea2055bc973787f0b09972f913f38b422a730ee\", \"mojo_unittests\": \"6e3635c44ccd260097015affdd3abbb472c06035\", \"nacl_helper_nonsfi_unittests\": \"e41c27281be29d84e9ff3af4423bbc0a75c448f2\", \"nacl_loader_unittests\": \"83fa531c84df402f99bbb7c7c7180d0a727186bc\", \"native_theme_unittests\": \"34f85a71ce6d8bf07e50fd9be0f8d5b9d09b9426\", \"net_unittests\": \"714a54f311d7e7e17ab4de24f52c2160ca903e12\", \"pdf_unittests\": \"1e5a821d15aa041b74a2f9aa70550533cafb1666\", \"perfetto_unittests\": \"5e25f8e87928db75e8b7bc6b9f1d06a79e2433ea\", \"ppapi_unittests\": \"f611704bffea9e2f6569c2abb389f31408d3f5d6\", \"printing_unittests\": \"c734b740fdca8cfa21920d8a628bdb449a2b625e\", \"remoting_unittests\": \"77f3bf571caf0127e5fc70db50b9e85a30f6473c\", \"sandbox_linux_unittests\": \"f077ad62754d18572a2ee9ce2d3d872a65c6e5a6\", \"service_manager_unittests\": \"01a1711753283dcdf7e2dd24e5d43ab214903504\", \"services_unittests\": \"9a60616e5c818dc2dd27c7cd3575980986aeea97\", \"shell_dialogs_unittests\": \"0c328a5f4a5809bb52501daf6fe3a608deb1dcad\", \"skia_unittests\": \"54ad6c14519db7665e2306c00f50f59933728462\", \"snapshot_unittests\": \"cea7a7924e3f4ee2e5875bb93668ceb0613e3c2b\", \"sql_unittests\": \"a3b4ee81735b81745ef66d3f2cdb4792e51234d2\", \"storage_unittests\": \"6d60b2cdf1ddf890dd2a081399d39231b3baa06b\", \"sync_integration_tests\": \"c68bda7e39634a6fbe5be4cd5a30b23d06525d09\", \"telemetry_gpu_unittests\": \"dbef89624849d8b66db53f3de78b0bec2cdded9f\", \"telemetry_perf_unittests\": \"76ffebbddf1fce4f32d1bc6c379a8e5b2f09c3a8\", \"telemetry_unittests\": \"a4b608bc54fae5c01ccfadff249a6846d5a933a4\", \"traffic_annotation_auditor_unittests\": \"a64efba7506677f55710f63ccb9d10a260be97de\", \"ui_base_unittests\": \"70f0f4b05d5de7733a7da930762d4a6d1f2305c6\", \"ui_touch_selection_unittests\": \"643df1db9d594805bf6de457bc15d2e680e37ddb\", \"unit_tests\": \"106c891f3f201e07f3bdd095ee8d4bdfd6f606c2\", \"url_unittests\": \"b8eaf0836e6db239d6632a693484058f3e084ff3\", \"views_perftests\": \"fbfce24549ea483c5559e3927a934769a92d3eef\", \"views_unittests\": \"0ff0a0a366a28e2bf00fa97e85a425c8ac08ebdb\", \"viz_unittests\": \"e2451b757f75eb95ac686dd3ce341eb3ac32aa8b\", \"vr_common_unittests\": \"9431f7bf892cddeb75365c5c4e799e15eb409699\", \"vr_pixeltests\": \"d10c20550199cff2060c479024c54c2534c45899\", \"webdriver_wpt_tests\": \"78704cf646c75f09a973418f83698c8bd4ebef8e\", \"weblayer_browsertests\": \"fdcf13687b112c0cdfba679bd1f90678a92371de\", \"wm_unittests\": \"7f09d69414e8d939e6d01c9c6de45bc44bd193fc\", \"wtf_unittests\": \"43966aecb6ac23de51aa7ef81baea7b6920562de\", \"xr_browser_tests\": \"fef1ba4201aa86df87c7acc215c3dc6b572faae9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_9ccb21220795a1d1972030c6b5d9b4569472a28790e1458f6676edb8e4495e8f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-128-133x\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580878683482609",
"status": "COMPLETED",
"status_changed_ts": "1580881620965525",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168241",
"builder:Linux Builder (dbg)",
"buildset:commit/git/05e3ba69aa1bd35c8e96a260e7b545675043599a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05e3ba69aa1bd35c8e96a260e7b545675043599a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054752631511536624",
"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/8889322569497550432/+/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:4a2c838cd68c3410",
"user_agent:luci-scheduler"
],
"updated_ts": "1580881620968962",
"url": "https://ci.chromium.org/b/8889322569497550432",
"utcnow_ts": "1580881622475654"
}
}
[05:47:02.531] Invocation finished in 53m46.408252295s with status SUCCEEDED