[07:21:22.264] New invocation is queued and will start shortly
[07:21:23.361] Starting the invocation (attempt 1)
[07:21:23.409] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:21:23.409] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:21:23.409] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055377492501296272",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3bb31f09191769cc5a2d0efd06267747f09d0051\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9055377492501296272",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3bb31f09191769cc5a2d0efd06267747f09d0051",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3bb31f09191769cc5a2d0efd06267747f09d0051",
"gitiles_ref:refs/heads/master"
]
}
[07:21:24.149] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580282483577017",
"id": "8889947430459246256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3bb31f09191769cc5a2d0efd06267747f09d0051\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580282483975503",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167973",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3bb31f09191769cc5a2d0efd06267747f09d0051",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3bb31f09191769cc5a2d0efd06267747f09d0051",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055377492501296272",
"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/8889947430459246256/+/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": "1580282483976179",
"url": "https://ci.chromium.org/b/8889947430459246256",
"utcnow_ts": "1580282484135394"
}
}
[07:21:24.149] Task URL: https://ci.chromium.org/b/8889947430459246256
[07:21:24.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:2:0) after 1m0s
[07:22:24.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:2:0)
[07:22:24.293] Timer tick, asking Buildbucket for the build status
[07:22:24.686] Build 8889947430459246256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:24.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:3:0) after 1m0s
[07:23:24.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:3:0)
[07:23:24.690] Timer tick, asking Buildbucket for the build status
[07:23:25.115] Build 8889947430459246256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:25.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:4:0) after 1m0s
[07:24:25.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:4:0)
[07:24:25.160] Timer tick, asking Buildbucket for the build status
[07:24:25.336] Build 8889947430459246256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:25.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:5:0) after 1m0s
[07:25:25.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:5:0)
[07:25:25.379] Timer tick, asking Buildbucket for the build status
[07:25:25.654] Build 8889947430459246256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:25.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:6:0) after 1m0s
[07:26:04.325] Received PubSub notification, asking Buildbucket for the build status
[07:26:04.492] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:25.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:6:0)
[07:26:25.729] Timer tick, asking Buildbucket for the build status
[07:26:25.929] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:25.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:8:0) after 1m0s
[07:27:26.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:8:0)
[07:27:26.076] Timer tick, asking Buildbucket for the build status
[07:27:26.518] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:26.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:9:0) after 1m0s
[07:28:26.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:9:0)
[07:28:26.584] Timer tick, asking Buildbucket for the build status
[07:28:26.867] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:26.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:10:0) after 1m0s
[07:29:26.904] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:10:0)
[07:29:26.904] Timer tick, asking Buildbucket for the build status
[07:29:27.030] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:27.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:11:0) after 1m0s
[07:30:27.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:11:0)
[07:30:27.144] Timer tick, asking Buildbucket for the build status
[07:30:27.306] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:27.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:12:0) after 1m0s
[07:31:27.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:12:0)
[07:31:27.448] Timer tick, asking Buildbucket for the build status
[07:31:27.879] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:27.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:13:0) after 1m0s
[07:32:27.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:13:0)
[07:32:27.893] Timer tick, asking Buildbucket for the build status
[07:32:28.063] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:28.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:14:0) after 1m0s
[07:33:28.081] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:14:0)
[07:33:28.081] Timer tick, asking Buildbucket for the build status
[07:33:28.255] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:28.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:15:0) after 1m0s
[07:34:28.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:15:0)
[07:34:28.334] Timer tick, asking Buildbucket for the build status
[07:34:28.810] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:28.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:16:0) after 1m0s
[07:35:28.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:16:0)
[07:35:28.854] Timer tick, asking Buildbucket for the build status
[07:35:29.016] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:29.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:17:0) after 1m0s
[07:36:29.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:17:0)
[07:36:29.067] Timer tick, asking Buildbucket for the build status
[07:36:29.576] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:29.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:18:0) after 1m0s
[07:37:29.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:18:0)
[07:37:29.581] Timer tick, asking Buildbucket for the build status
[07:37:29.858] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:29.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:19:0) after 1m0s
[07:38:29.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:19:0)
[07:38:29.907] Timer tick, asking Buildbucket for the build status
[07:38:30.267] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:30.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:20:0) after 1m0s
[07:39:30.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:20:0)
[07:39:30.412] Timer tick, asking Buildbucket for the build status
[07:39:30.593] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:30.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:21:0) after 1m0s
[07:40:30.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:21:0)
[07:40:30.636] Timer tick, asking Buildbucket for the build status
[07:40:30.817] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:30.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:22:0) after 1m0s
[07:41:30.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:22:0)
[07:41:30.982] Timer tick, asking Buildbucket for the build status
[07:41:31.144] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:31.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:23:0) after 1m0s
[07:42:31.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:23:0)
[07:42:31.233] Timer tick, asking Buildbucket for the build status
[07:42:31.665] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:31.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:24:0) after 1m0s
[07:43:31.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:24:0)
[07:43:31.720] Timer tick, asking Buildbucket for the build status
[07:43:32.355] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:32.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:25:0) after 1m0s
[07:44:32.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:25:0)
[07:44:32.448] Timer tick, asking Buildbucket for the build status
[07:44:32.596] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:32.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:26:0) after 1m0s
[07:45:32.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:26:0)
[07:45:32.615] Timer tick, asking Buildbucket for the build status
[07:45:32.791] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:32.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:27:0) after 1m0s
[07:46:32.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:27:0)
[07:46:32.841] Timer tick, asking Buildbucket for the build status
[07:46:33.490] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:33.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:28:0) after 1m0s
[07:47:33.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:28:0)
[07:47:33.499] Timer tick, asking Buildbucket for the build status
[07:47:33.654] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:33.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:29:0) after 1m0s
[07:48:33.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:29:0)
[07:48:33.739] Timer tick, asking Buildbucket for the build status
[07:48:34.507] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:34.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:30:0) after 1m0s
[07:49:34.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:30:0)
[07:49:34.542] Timer tick, asking Buildbucket for the build status
[07:49:34.834] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:34.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:31:0) after 1m0s
[07:50:34.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:31:0)
[07:50:34.948] Timer tick, asking Buildbucket for the build status
[07:50:35.196] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:35.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:32:0) after 1m0s
[07:51:35.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:32:0)
[07:51:35.273] Timer tick, asking Buildbucket for the build status
[07:51:35.868] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:35.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:33:0) after 1m0s
[07:52:35.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:33:0)
[07:52:35.928] Timer tick, asking Buildbucket for the build status
[07:52:36.182] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:36.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:34:0) after 1m0s
[07:53:36.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:34:0)
[07:53:36.203] Timer tick, asking Buildbucket for the build status
[07:53:36.781] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:36.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:35:0) after 1m0s
[07:54:36.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:35:0)
[07:54:36.813] Timer tick, asking Buildbucket for the build status
[07:54:37.045] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:37.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:36:0) after 1m0s
[07:55:37.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:36:0)
[07:55:37.065] Timer tick, asking Buildbucket for the build status
[07:55:37.234] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:37.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:37:0) after 1m0s
[07:56:37.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:37:0)
[07:56:37.250] Timer tick, asking Buildbucket for the build status
[07:56:37.390] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:37.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:38:0) after 1m0s
[07:57:37.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:38:0)
[07:57:37.431] Timer tick, asking Buildbucket for the build status
[07:57:37.978] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:37.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:39:0) after 1m0s
[07:58:38.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:39:0)
[07:58:38.062] Timer tick, asking Buildbucket for the build status
[07:58:38.871] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:38.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:40:0) after 1m0s
[07:59:38.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:40:0)
[07:59:38.966] Timer tick, asking Buildbucket for the build status
[07:59:39.127] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:39.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:41:0) after 1m0s
[08:00:39.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:41:0)
[08:00:39.187] Timer tick, asking Buildbucket for the build status
[08:00:39.317] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:39.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:42:0) after 1m0s
[08:01:39.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:42:0)
[08:01:39.349] Timer tick, asking Buildbucket for the build status
[08:01:40.204] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:40.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:43:0) after 1m0s
[08:02:40.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:43:0)
[08:02:40.310] Timer tick, asking Buildbucket for the build status
[08:02:40.485] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:40.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:44:0) after 1m0s
[08:03:40.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:44:0)
[08:03:40.479] Timer tick, asking Buildbucket for the build status
[08:03:40.638] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:40.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:45:0) after 1m0s
[08:04:40.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:45:0)
[08:04:40.725] Timer tick, asking Buildbucket for the build status
[08:04:40.875] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:40.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:46:0) after 1m0s
[08:05:41.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:46:0)
[08:05:41.039] Timer tick, asking Buildbucket for the build status
[08:05:41.224] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:41.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:47:0) after 1m0s
[08:06:41.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:47:0)
[08:06:41.276] Timer tick, asking Buildbucket for the build status
[08:06:41.697] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:41.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:48:0) after 1m0s
[08:07:41.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:48:0)
[08:07:41.811] Timer tick, asking Buildbucket for the build status
[08:07:43.501] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:43.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:49:0) after 1m0s
[08:08:43.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:49:0)
[08:08:43.498] Timer tick, asking Buildbucket for the build status
[08:08:43.649] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:43.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:50:0) after 1m0s
[08:09:43.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:50:0)
[08:09:43.669] Timer tick, asking Buildbucket for the build status
[08:09:44.170] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:44.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:51:0) after 1m0s
[08:10:44.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:51:0)
[08:10:44.195] Timer tick, asking Buildbucket for the build status
[08:10:44.446] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:44.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:52:0) after 1m0s
[08:11:44.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:52:0)
[08:11:44.537] Timer tick, asking Buildbucket for the build status
[08:11:44.727] Build 8889947430459246256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:44.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9055377492501296272:53:0) after 1m0s
[08:12:12.436] Received PubSub notification, asking Buildbucket for the build status
[08:12:13.244] Build 8889947430459246256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:12:13.244] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580285530028878",
"created_by": "project:chromium",
"created_ts": "1580282483577017",
"id": "8889947430459246256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3bb31f09191769cc5a2d0efd06267747f09d0051\"}}",
"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-east1-d-8-19-ja2z\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167973, \"got_angle_revision\": \"44c75073811b193ca1840649d57c53b04a0caf51\", \"got_dawn_revision\": \"7b6246a2ade815a032e1abc8df1be7c72d3dd0c2\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3bb31f09191769cc5a2d0efd06267747f09d0051\", \"got_revision_cp\": \"refs/heads/master@{#736262}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6c3dc3581eaf4345c0507d5ac7bb013d55351547\", \"got_v8_revision\": \"390a4513a584df618c36884766c69b46da421c94\", \"got_v8_revision_cp\": \"refs/heads/8.1.297@{#1}\", \"got_webrtc_revision\": \"5d3173be305d05702d3e9fe75a9a1bb05564694f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30397}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3bb31f09191769cc5a2d0efd06267747f09d0051\", \"swarm_hashes_refs/heads/master(at){#736262}_without_patch\": {\"accessibility_unittests\": \"b59464caae05d80844769bb7ede712d09bac528c\", \"angle_unittests\": \"973a75bd356f8abe5a25981061da711df8f26791\", \"app_shell_unittests\": \"430e06aa3312058ca91661a61d78bb9af052beb9\", \"aura_unittests\": \"13149fd585f8637164dfdae7699c81dfbd0ac463\", \"base_unittests\": \"bcff461238c5f474aa68ee79b2c3a8dbfe81eb09\", \"base_util_unittests\": \"bbe49e4f8cacc028f92fdf8b8cfd47be58d1a04d\", \"blink_common_unittests\": \"b7217517472bf5003f364dfcee11c5f6fa99a251\", \"blink_fuzzer_unittests\": \"9641cb0b1eebc7d6122f9551a023e47f35a79e2d\", \"blink_heap_unittests\": \"09151730368e3431428625df395a71cf436f10bd\", \"blink_platform_unittests\": \"3eb2cf9413966e415f56e73911244f5c1c569ea4\", \"blink_python_tests\": \"f1d2387a0fd679400011fce7f49ca02e5c63a194\", \"blink_unittests\": \"946f7a511182a7791721e8169e8c4bb404bfcd6e\", \"blink_web_tests\": \"e6a2fe8bf96ecc78c0dce55ab6193b168c174702\", \"boringssl_crypto_tests\": \"ac6e81ffe8fef5b1c853f6a23de6d37f3a014976\", \"boringssl_ssl_tests\": \"7e43212a1c533b6af8fbb00c59ad3e98901bd656\", \"browser_tests\": \"bd7ddadd79ecdb188195f66b2da89e7c6754b5a5\", \"cacheinvalidation_unittests\": \"6c5d509a89058edad360b29f5c68ac39b8988c60\", \"capture_unittests\": \"30d8303668469d4bfd1b3377810dc6bde1f45371\", \"cast_unittests\": \"5131b7056cc4a5c3395018cb6f9006f40c14b752\", \"cc_unittests\": \"5dce54a67dc201baa75936b73aa9bd2703848326\", \"chrome_app_unittests\": \"be9ec36deec085c99adf52df48624718e827c168\", \"chromedriver_unittests\": \"5c5e86a1d305ada94a2b8305bac13e5dd4705688\", \"components_browsertests\": \"248c928b8fd5fba65a5d44b17dff37fad24fde83\", \"components_unittests\": \"28b987c8cbee9fac06593b980fe058a1d567e33a\", \"compositor_unittests\": \"eca4b2d2da1d3a67a350b3a68dbed4242b5193bf\", \"content_browsertests\": \"370ba5aff9a11fb3025ae699faa15cc775296f7b\", \"content_shell_crash_test\": \"a978ed53d176bc860d9e0ed691b357811505239c\", \"content_unittests\": \"dc486d55f83f291ba435fdaf78a54d7e194db12f\", \"crashpad_tests\": \"1fad081c5212bd6f8e7b9c2621e36171c27b0f83\", \"cronet_tests\": \"a568108428720769b285ef36a19803bb0e25859e\", \"cronet_unittests\": \"761681058d62873016e49db94e7392cce3141992\", \"crypto_unittests\": \"70f4c6ae330dc17cbaa3293f96f89a24a2829c30\", \"dbus_unittests\": \"8d00c5b4293be0d0e0a72182209a101dbec4d061\", \"device_unittests\": \"a1114d1983cfacf01d93487522923c2b8a503807\", \"display_unittests\": \"68a0f08a6bccf6439f4071cade833f3a937df89e\", \"events_unittests\": \"47c7187fbbb05a14b9a57a9ce7611883b1596204\", \"extensions_browsertests\": \"2335634f7fad923389e3ef9809cad1468053784d\", \"extensions_unittests\": \"b28dc87e42bbddb5c2f3e539833b288ccde15088\", \"filesystem_service_unittests\": \"b74fa1b740a19101e258ae5c82c850ba3f45451f\", \"flatbuffers_unittests\": \"92c174f535dbe8e15f58589d59dc88efc29a10d4\", \"gcm_unit_tests\": \"f1f4a11431228415c6662498d452dc2ced6dfa7a\", \"gfx_unittests\": \"179d0bbccc6fe2a60badd09e0f36ff9e9814d6c9\", \"gin_unittests\": \"c09301a8b815686bcbc09da1ec7121977dab8c75\", \"google_apis_unittests\": \"a2b881660e3d4d2a0f083dc1d21ce9de6432244a\", \"gpu_unittests\": \"450ac557585318139a0fcf7345400a42578eeff7\", \"grit_python_unittests\": \"896da2265579af982b0c06ff8662522b696fea99\", \"gwp_asan_unittests\": \"d8604673e19e0d18353dcbf5300185e78b40d0c9\", \"headless_browsertests\": \"3274fd982b92425ea053df9ab167e02b60c5b142\", \"headless_unittests\": \"a606c4806a9a70d50330d90d880111d3bd019ac0\", \"interactive_ui_tests\": \"b1dda0239a0a3c125af68c19232a1ac574669af5\", \"ipc_tests\": \"d9cc732043b3727674da783e1919cc51668f26d1\", \"jingle_unittests\": \"824697f7f9a14bbdccdc77aa415e3edbbdc5ef44\", \"latency_unittests\": \"91bd46079a4e7ec5c77c5a0bde12f68233c300ee\", \"libjingle_xmpp_unittests\": \"0d918052046dd67630263e112a38c0b7d84b62a8\", \"media_blink_unittests\": \"ea3f0ccee9f714db27548ae9b2be61be5272016a\", \"media_service_unittests\": \"cb57313059321940e43f7886658b72c41f8f36dc\", \"media_unittests\": \"491d912c4a69b19d976200123dd8b4a8bc86fb41\", \"message_center_unittests\": \"5b8cbb62b4b3328f235ded5010d6cd351163b5f7\", \"metrics_python_tests\": \"d37875ecdf0232df11ffee8759cff2d49931ca55\", \"midi_unittests\": \"7616ec76498cc41cf442db116d64a382c5da1123\", \"mojo_core_unittests\": \"16a9134aa42ad060c17ac60f56ed8b8b730fa3f8\", \"mojo_unittests\": \"3698ebfb6214a658cde405946fc4c0cf1fb77d57\", \"nacl_helper_nonsfi_unittests\": \"63c9166f7d293f83fed335b45054de0643144f61\", \"nacl_loader_unittests\": \"b71ba8f54215660a4eefb267ef11efd99119dc93\", \"native_theme_unittests\": \"e0c802907802aaad5feb894bbf2bc4653785be12\", \"net_unittests\": \"d01b136f294efae10e459d8fcfeee6679bdb0798\", \"pdf_unittests\": \"a27eb1869bdb5802db85034ced73b6be65ac30dd\", \"perfetto_unittests\": \"d847a218c49b9a5440bc2c20eb783c0ea92d5484\", \"ppapi_unittests\": \"eb5622cb949068a9fd093dbfc1f5ec85feabeb33\", \"printing_unittests\": \"8490f443cefbff9e2daa73563713305b2518a08e\", \"remoting_unittests\": \"fb390cdffd1085fcc61440c3b5e4bee254c6a243\", \"sandbox_linux_unittests\": \"953f29d808c437cdb1946ed426a23601b507edb5\", \"service_manager_unittests\": \"dd06115a1c3b50ad87a3dea1b5d2de3539f419b1\", \"services_unittests\": \"388472f26b827a8617a18d2d8f0f00c64aa9bff9\", \"shell_dialogs_unittests\": \"81cab18b2403a22609d43dc9ce5baf8eef247c56\", \"skia_unittests\": \"fe27488d54902dd9c0f451b849a3603e7a368952\", \"snapshot_unittests\": \"e2aaaae8881c8dbbfd8396b54ed4e021b775d705\", \"sql_unittests\": \"5e4d0a9d12152d0983c19dec049839281956c515\", \"storage_unittests\": \"d72f93197897666c8e2ad45f0023d95051712f1f\", \"sync_integration_tests\": \"89a2a7cdc13b3027077d804cb95716043ae86b04\", \"telemetry_gpu_unittests\": \"47b4554b1231fb75d2eed791ca170dd946f72209\", \"telemetry_perf_unittests\": \"da04df512af3e1287678f15181cc871c953ce8ee\", \"telemetry_unittests\": \"971b304e01120ecbbcee310e385880407e66d01e\", \"traffic_annotation_auditor_unittests\": \"07c253e83a787518a2f277c4fb02d13ae27df7cb\", \"ui_base_unittests\": \"9f401f1a193e633f450030df70852bc720975387\", \"ui_touch_selection_unittests\": \"f19fd9b3169a1bf38ce325e94bf612fc363458c9\", \"unit_tests\": \"7b0004398d3ab5dadf089f9d13b67a99be8880d0\", \"url_unittests\": \"9665e60295ec976a60f752803722ec49941f5895\", \"views_perftests\": \"9a954aa6ed9de912c9a121fa208359e1b6fe40ca\", \"views_unittests\": \"ec6e6d564773ab6dc30a74b4ce07edfc3dbf630d\", \"viz_unittests\": \"b87a088ec3cd21899d0c28ef40d0cd967bc8cbd6\", \"vr_common_unittests\": \"ed8fe98fce22266a6681bf8d8e1dfd31fcd018e1\", \"vr_pixeltests\": \"aeb63f3b42a4a2de41a3f48ffbf0295c3c2df45a\", \"webdriver_wpt_tests\": \"c427c5152c9c187bdbe639b24940d84b85fc85a4\", \"weblayer_browsertests\": \"e5f1eeeebe7fb66eef8f492adc2dfe7b4ebb3dd5\", \"wm_unittests\": \"f85561e71b716f7f92c3223d216d7c4b58b72e10\", \"wtf_unittests\": \"f0141aae154dbd16700118f345ac32b7b9945b99\", \"xr_browser_tests\": \"709be5233dd02a12b2c7e0b4f60e7dcd83ce5fc2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_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-east1-d-8-19-ja2z\"], \"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\": [\"4803-37cc110\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580282763177078",
"status": "COMPLETED",
"status_changed_ts": "1580285530305222",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167973",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3bb31f09191769cc5a2d0efd06267747f09d0051",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3bb31f09191769cc5a2d0efd06267747f09d0051",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055377492501296272",
"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/8889947430459246256/+/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:4a08fe9ec78c9e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1580285530311079",
"url": "https://ci.chromium.org/b/8889947430459246256",
"utcnow_ts": "1580285533219586"
}
}
[08:12:13.244] Invocation finished in 50m50.998423267s with status SUCCEEDED