[10:38:32.763] New invocation is queued and will start shortly
[10:38:33.900] Starting the invocation (attempt 1)
[10:38:33.932] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:38:33.932] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:38:33.932] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018401525030723680",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"abd32d7284c10d14dfbe6c6da0be3118d98170c5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018401525030723680",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/abd32d7284c10d14dfbe6c6da0be3118d98170c5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abd32d7284c10d14dfbe6c6da0be3118d98170c5",
"gitiles_ref:refs/heads/master"
]
}
[10:38:34.756] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615545514056561",
"id": "8852971463011384320",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abd32d7284c10d14dfbe6c6da0be3118d98170c5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615545514625102",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181330",
"builder:Linux Builder (dbg)",
"buildset:commit/git/abd32d7284c10d14dfbe6c6da0be3118d98170c5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abd32d7284c10d14dfbe6c6da0be3118d98170c5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018401525030723680",
"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/8852971463011384320/+/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": "1615545514625205",
"url": "https://ci.chromium.org/b/8852971463011384320",
"utcnow_ts": "1615545514749286"
}
}
[10:38:34.756] Task URL: https://ci.chromium.org/b/8852971463011384320
[10:38:34.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:2:0) after 1m0s
[10:38:42.629] Received PubSub notification, asking Buildbucket for the build status
[10:38:42.686] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:34.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:2:0)
[10:39:34.769] Timer tick, asking Buildbucket for the build status
[10:39:34.835] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:34.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:4:0) after 1m0s
[10:40:34.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:4:0)
[10:40:34.849] Timer tick, asking Buildbucket for the build status
[10:40:34.914] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:34.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:5:0) after 1m0s
[10:41:34.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:5:0)
[10:41:34.938] Timer tick, asking Buildbucket for the build status
[10:41:35.084] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:35.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:6:0) after 1m0s
[10:42:35.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:6:0)
[10:42:35.118] Timer tick, asking Buildbucket for the build status
[10:42:35.319] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:35.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:7:0) after 1m0s
[10:43:35.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:7:0)
[10:43:35.334] Timer tick, asking Buildbucket for the build status
[10:43:35.450] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:35.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:8:0) after 1m0s
[10:44:35.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:8:0)
[10:44:35.492] Timer tick, asking Buildbucket for the build status
[10:44:35.719] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:35.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:9:0) after 1m0s
[10:45:35.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:9:0)
[10:45:35.740] Timer tick, asking Buildbucket for the build status
[10:45:35.814] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:35.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:10:0) after 1m0s
[10:46:35.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:10:0)
[10:46:35.835] Timer tick, asking Buildbucket for the build status
[10:46:35.896] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:35.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:11:0) after 1m0s
[10:47:35.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:11:0)
[10:47:35.910] Timer tick, asking Buildbucket for the build status
[10:47:35.991] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:35.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:12:0) after 1m0s
[10:48:36.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:12:0)
[10:48:36.007] Timer tick, asking Buildbucket for the build status
[10:48:36.081] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:36.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:13:0) after 1m0s
[10:49:36.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:13:0)
[10:49:36.101] Timer tick, asking Buildbucket for the build status
[10:49:36.169] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:36.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:14:0) after 1m0s
[10:50:36.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:14:0)
[10:50:36.257] Timer tick, asking Buildbucket for the build status
[10:50:36.413] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:36.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:15:0) after 1m0s
[10:51:36.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:15:0)
[10:51:36.534] Timer tick, asking Buildbucket for the build status
[10:51:36.607] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:36.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:16:0) after 1m0s
[10:52:36.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:16:0)
[10:52:36.676] Timer tick, asking Buildbucket for the build status
[10:52:36.764] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:36.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:17:0) after 1m0s
[10:53:36.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:17:0)
[10:53:36.771] Timer tick, asking Buildbucket for the build status
[10:53:36.994] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:36.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:18:0) after 1m0s
[10:54:37.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:18:0)
[10:54:37.005] Timer tick, asking Buildbucket for the build status
[10:54:37.123] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:37.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:19:0) after 1m0s
[10:55:37.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:19:0)
[10:55:37.140] Timer tick, asking Buildbucket for the build status
[10:55:37.224] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:37.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:20:0) after 1m0s
[10:56:37.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:20:0)
[10:56:37.229] Timer tick, asking Buildbucket for the build status
[10:56:37.432] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:37.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:21:0) after 1m0s
[10:57:37.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:21:0)
[10:57:37.503] Timer tick, asking Buildbucket for the build status
[10:57:37.566] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:37.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:22:0) after 1m0s
[10:58:37.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:22:0)
[10:58:37.613] Timer tick, asking Buildbucket for the build status
[10:58:37.681] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:37.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:23:0) after 1m0s
[10:59:37.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:23:0)
[10:59:37.722] Timer tick, asking Buildbucket for the build status
[10:59:37.994] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:37.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:24:0) after 1m0s
[11:00:38.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:24:0)
[11:00:38.013] Timer tick, asking Buildbucket for the build status
[11:00:38.124] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:38.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:25:0) after 1m0s
[11:01:38.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:25:0)
[11:01:38.143] Timer tick, asking Buildbucket for the build status
[11:01:38.209] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:38.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:26:0) after 1m0s
[11:02:38.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:26:0)
[11:02:38.251] Timer tick, asking Buildbucket for the build status
[11:02:38.320] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:38.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:27:0) after 1m0s
[11:03:38.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:27:0)
[11:03:38.386] Timer tick, asking Buildbucket for the build status
[11:03:38.474] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:38.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:28:0) after 1m0s
[11:04:38.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:28:0)
[11:04:38.448] Timer tick, asking Buildbucket for the build status
[11:04:38.518] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:38.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:29:0) after 1m0s
[11:05:38.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:29:0)
[11:05:38.561] Timer tick, asking Buildbucket for the build status
[11:05:38.630] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:38.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:30:0) after 1m0s
[11:06:38.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:30:0)
[11:06:38.645] Timer tick, asking Buildbucket for the build status
[11:06:38.708] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:38.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:31:0) after 1m0s
[11:07:38.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:31:0)
[11:07:38.731] Timer tick, asking Buildbucket for the build status
[11:07:38.796] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:38.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:32:0) after 1m0s
[11:08:38.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:32:0)
[11:08:38.846] Timer tick, asking Buildbucket for the build status
[11:08:38.954] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:38.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:33:0) after 1m0s
[11:09:39.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:33:0)
[11:09:39.034] Timer tick, asking Buildbucket for the build status
[11:09:39.404] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:39.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:34:0) after 1m0s
[11:10:39.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:34:0)
[11:10:39.479] Timer tick, asking Buildbucket for the build status
[11:10:39.564] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:39.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:35:0) after 1m0s
[11:11:39.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:35:0)
[11:11:39.550] Timer tick, asking Buildbucket for the build status
[11:11:39.632] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:39.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:36:0) after 1m0s
[11:12:39.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:36:0)
[11:12:39.756] Timer tick, asking Buildbucket for the build status
[11:12:40.064] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:40.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:37:0) after 1m0s
[11:13:40.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:37:0)
[11:13:40.059] Timer tick, asking Buildbucket for the build status
[11:13:40.150] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:40.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:38:0) after 1m0s
[11:14:40.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:38:0)
[11:14:40.207] Timer tick, asking Buildbucket for the build status
[11:14:40.347] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:40.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:39:0) after 1m0s
[11:15:40.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:39:0)
[11:15:40.397] Timer tick, asking Buildbucket for the build status
[11:15:41.081] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:41.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:40:0) after 1m0s
[11:16:41.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:40:0)
[11:16:41.131] Timer tick, asking Buildbucket for the build status
[11:16:41.346] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:41:0) after 1m0s
[11:17:41.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:41:0)
[11:17:41.484] Timer tick, asking Buildbucket for the build status
[11:17:41.558] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:41.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:42:0) after 1m0s
[11:18:41.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:42:0)
[11:18:41.694] Timer tick, asking Buildbucket for the build status
[11:18:41.913] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:41.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:43:0) after 1m0s
[11:19:41.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:43:0)
[11:19:41.974] Timer tick, asking Buildbucket for the build status
[11:19:42.041] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:42.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:44:0) after 1m0s
[11:20:42.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:44:0)
[11:20:42.072] Timer tick, asking Buildbucket for the build status
[11:20:42.160] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:42.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:45:0) after 1m0s
[11:21:42.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:45:0)
[11:21:42.408] Timer tick, asking Buildbucket for the build status
[11:21:42.577] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:42.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:46:0) after 1m0s
[11:22:42.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:46:0)
[11:22:42.625] Timer tick, asking Buildbucket for the build status
[11:22:42.692] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:42.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:47:0) after 1m0s
[11:23:42.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:47:0)
[11:23:42.948] Timer tick, asking Buildbucket for the build status
[11:23:43.044] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:43.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:48:0) after 1m0s
[11:24:43.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:48:0)
[11:24:43.204] Timer tick, asking Buildbucket for the build status
[11:24:43.271] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:43.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:49:0) after 1m0s
[11:25:43.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:49:0)
[11:25:43.371] Timer tick, asking Buildbucket for the build status
[11:25:43.562] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:43.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:50:0) after 1m0s
[11:26:43.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:50:0)
[11:26:43.612] Timer tick, asking Buildbucket for the build status
[11:26:43.681] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:43.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:51:0) after 1m0s
[11:27:43.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:51:0)
[11:27:43.685] Timer tick, asking Buildbucket for the build status
[11:27:43.769] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:43.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:52:0) after 1m0s
[11:28:43.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:52:0)
[11:28:43.787] Timer tick, asking Buildbucket for the build status
[11:28:43.875] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:43.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:53:0) after 1m0s
[11:29:43.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:53:0)
[11:29:43.994] Timer tick, asking Buildbucket for the build status
[11:29:44.247] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:44.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:54:0) after 1m0s
[11:30:44.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:54:0)
[11:30:44.314] Timer tick, asking Buildbucket for the build status
[11:30:44.390] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:44.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:55:0) after 1m0s
[11:31:44.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:55:0)
[11:31:44.619] Timer tick, asking Buildbucket for the build status
[11:31:44.894] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:44.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:56:0) after 1m0s
[11:32:44.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:56:0)
[11:32:44.928] Timer tick, asking Buildbucket for the build status
[11:32:45.007] Build 8852971463011384320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:45.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018401525030723680:57:0) after 1m0s
[11:33:29.386] Received PubSub notification, asking Buildbucket for the build status
[11:33:29.698] Build 8852971463011384320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:33:29.698] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615548808645396",
"created_by": "project:chromium",
"created_ts": "1615545514056561",
"id": "8852971463011384320",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abd32d7284c10d14dfbe6c6da0be3118d98170c5\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"abd32d7284c10d14dfbe6c6da0be3118d98170c5\", \"project\": \"chromium/src\"}], \"$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-149-4156\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181330, \"got_angle_revision\": \"225e1952d49477a114942c86328cb294e52781c6\", \"got_dawn_revision\": \"2f72aeda4fa52c3e7eb6276b0a59b1d568983517\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"abd32d7284c10d14dfbe6c6da0be3118d98170c5\", \"got_revision_cp\": \"refs/heads/master@{#862363}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3c4fd15fb075ab3a8eb5809f9a42b5faa9ac63ae\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"14a626af56675c9d95f9fb207d53366a53a95fbd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33409}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abd32d7284c10d14dfbe6c6da0be3118d98170c5\", \"swarm_hashes_refs/heads/master(at){#862363}_without_patch\": {\"absl_hardening_tests\": \"e38da0205bae41b7469c1137a846fea6d1143c62\", \"accessibility_unittests\": \"8d7a3b202b50d663e7508170f19f9f2045325aac\", \"angle_unittests\": \"a05b90760ea52576521a02e5155f7864674bd580\", \"app_shell_unittests\": \"0d9101edd99e12c12d70fedd83c7d56f53c7736a\", \"aura_unittests\": \"3b832aafc93a3a842768b0516cdba812381127e2\", \"base_unittests\": \"87ffba2152c56b0a24f06e92f6fb91174ffa7f89\", \"base_util_unittests\": \"c42be76c6b98fdf02a30cfeb0718129bc3847fed\", \"blink_common_unittests\": \"44d84ce25e78415fcce5910a9ece50a55b1af215\", \"blink_fuzzer_unittests\": \"2d9d5ebb858f2bf996593c4c8858d0af14e9ffb0\", \"blink_heap_unittests\": \"7975d9e7a5d2b798c7fc9f5f5b9f2493d46c5b5b\", \"blink_platform_unittests\": \"ce005610c7cc32642df4965699d6ce5ca9a70288\", \"blink_python_tests\": \"85304a3d44f7529cde93b56044662ea6bed6c4c7\", \"blink_unittests\": \"740f9e966091813421b49d6a7c24aec2d559ac18\", \"blink_web_tests\": \"24209a38d127070209ef338db5b42aed1d4f87fe\", \"boringssl_crypto_tests\": \"9fbb70b5114474b7e2af2ba87e665f551f4dc80e\", \"boringssl_ssl_tests\": \"ecb5f9b95be13427aaa7129c30b9ba242e4d090d\", \"browser_tests\": \"ef7956831edbe283dda2d7c8fd1f4fae344d1251\", \"capture_unittests\": \"f4ad8b2d9a737e10c6185f1066f9db6e7ee75144\", \"cast_unittests\": \"d50122e609cf2864b3e5c0dfdbe3137013644676\", \"cc_unittests\": \"232ff85b39950bf3f627309765044d1e74b959ba\", \"chrome_app_unittests\": \"23db13478578e0b3a979c4975142ab94bf62e433\", \"chromedriver_unittests\": \"dcc6aa7769c98ce480602c82868ba4b9c7f22965\", \"color_unittests\": \"9831617c131808d93b05e7de90d88558f1d7f304\", \"components_browsertests\": \"06ae453b890b792a448650c7e41a8619d9059034\", \"components_unittests\": \"c7a55d52b911dcd0b462b60a3b3f643c849979b9\", \"compositor_unittests\": \"45c2230f4b049995c5a70fa77030af00035e90d0\", \"content_browsertests\": \"3cd9c8f94cb0c5b1b95c7f316720760fe41788e0\", \"content_shell_crash_test\": \"8d8bd9da936d3935ac69c90e1c7889083383cc52\", \"content_unittests\": \"f524d3acdb80762ad217335c635a77917860d54a\", \"crashpad_tests\": \"0f02457d443e1e3fb614b1ca8d1b72f37724f7f6\", \"cronet_tests\": \"30aa422867de3467e9bce320f15a0bd58d301699\", \"cronet_unittests\": \"cef5261828a5a8bfea901588a85aacf807a34950\", \"crypto_unittests\": \"20b57e93987782e30549b6e926012d97d757a65e\", \"dbus_unittests\": \"2531a3b1ada35239b8a9c017694ce9c712854ccc\", \"device_unittests\": \"c2dec7287b569b45b7abab67bc04863f061c61a0\", \"display_unittests\": \"c76747ecd33d5218ebc4bfdf849fdd6841e8e049\", \"events_unittests\": \"0f55e6800af83340a868637a7efae77a43129e50\", \"extensions_browsertests\": \"f3985d91361c120b012fa07597f945affc62103b\", \"extensions_unittests\": \"5bb410a631b7b394bd87ea3081c9e942f478bf79\", \"filesystem_service_unittests\": \"c0341e0112424bb322123fae1481f88edbf04372\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"426342e811a7b9a61bd9dcba9b9874596ea22926\", \"gfx_unittests\": \"4425df769e8059248ef4f3be6eb89c2e52acf85b\", \"gin_unittests\": \"7abc090740c95093d6b258ed67c641cef86e93ee\", \"google_apis_unittests\": \"c75dcc7580c40e4f91ca333082b2c199650ed352\", \"gpu_unittests\": \"1867f8bfc2020f0e34e5500d6b62bcbd2ffeaada\", \"grit_python_unittests\": \"34dc6f3cc2d88a5fac848f4742c34f024387cdb5\", \"gwp_asan_unittests\": \"5da8f585f97685b92b8e7af72b05e4ceebd573ce\", \"headless_browsertests\": \"9503ae64a626b305d8e5ecb3c97a327b88f63f35\", \"headless_unittests\": \"0b13470cd371757f0d1f026036dee42b7559b089\", \"interactive_ui_tests\": \"2732c1decea0a5db37e8e1f2c687c6f100d9d2f6\", \"ipc_tests\": \"d3590f05a041a7c2c760160c24a98eb9a9f387fc\", \"jingle_unittests\": \"a3f231c724b4b354758447e6aa4fb087f41f11a9\", \"latency_unittests\": \"54213b4b6b1f7437458b768fd166a2018266622d\", \"libjingle_xmpp_unittests\": \"4ac0cbd70ec9e0a2bd5e6ed89d12aa938bcdb42b\", \"liburlpattern_unittests\": \"27005479ceab748f19068dd0e5948b08e5077c9c\", \"media_blink_unittests\": \"70fd4d2a81228e57af6010bcee3fbc02fc0b8d31\", \"media_unittests\": \"af94ac4ae85bb8ea4c22f33015555874642f6d83\", \"message_center_unittests\": \"b99f024167ea617c51ca306ff8e0dfd72fb22469\", \"metrics_python_tests\": \"5451d891eabed5f67c841ff008fdafea5b5066ad\", \"midi_unittests\": \"ced63c4ed7aa9ea38d959810cfb00adafdf4d6c7\", \"mojo_core_unittests\": \"e85645d2ea88a11f7ca7f51cf434bf824a0789bc\", \"mojo_unittests\": \"2d877d4cc88df6bc9708185dc88b0ab3590bd3f4\", \"nacl_helper_nonsfi_unittests\": \"789ac1870ae0da80f5d9b66adcc110945f994fc1\", \"nacl_loader_unittests\": \"8a96023a1633dbec98b4be931ecafabfe01238f0\", \"native_theme_unittests\": \"091b9ecda0f6f4b283168d4d9db5bc3877b39ace\", \"net_unittests\": \"91a5a15385426913cf104c0647a70c6f1c455999\", \"openscreen_unittests\": \"579a8538572e77b487af1db65373cdbb6a4e2bd9\", \"pdf_unittests\": \"bf694844406b5dabe808a5e9aa793834cc192213\", \"perfetto_unittests\": \"342d5ad19fc051134e8e16428d07d1629fcc8d47\", \"ppapi_unittests\": \"1454f5292f21a552b152bd4d56df6f34db91227c\", \"printing_unittests\": \"6676e270eede07c7dbe5a62e865a4b72ebf62b6a\", \"remoting_unittests\": \"16e065bb81de134ab332042816199094cc6ca8f4\", \"sandbox_linux_unittests\": \"18b9d7c60b1c5e6dda3625392d6de28a6f72492a\", \"service_manager_unittests\": \"83385536c6a09e168e34a37503bfa3ca4ce9d9e0\", \"services_unittests\": \"3459839634070382c5c0d8751ee0c0edf241fb05\", \"shell_dialogs_unittests\": \"b7e554bb99b465e26f91c190da75d80c178c9c12\", \"skia_unittests\": \"c3b9f0da396775aeb4df809a6bc413bbe191c84b\", \"snapshot_unittests\": \"e9df04ce1c66099299604e6f498804e9bb19a4a6\", \"sql_unittests\": \"22336d3c853ca6fea5c535456a8193ea3987e361\", \"storage_unittests\": \"5b3b91c12103586b251ecd6f210f2ddfc748c008\", \"sync_integration_tests\": \"6ff8b1516f8829a2625a88724d0fa509757222fc\", \"telemetry_gpu_unittests\": \"45509679d55ea1f36d83a0cb22ef61b7e69736a4\", \"telemetry_perf_unittests\": \"34092c822bafe1627dc76cfee1a147823f50ac33\", \"telemetry_unittests\": \"285f8609e47fa4077e9e2c1b442dd88d11a5e10b\", \"traffic_annotation_auditor_unittests\": \"7a3f0a1de107b8e277dfc8f04fbcd888e59c411b\", \"ui_base_unittests\": \"fcf7a2e847bffab476355127890dfb705a1d458b\", \"ui_touch_selection_unittests\": \"919a1b3105aed509dcc841c7452f95b282e08dea\", \"unit_tests\": \"a7a58c8c22830d3347906f3da9dbb338d87688c5\", \"url_unittests\": \"c73b0137c2ee949816407f96864edab68fde9b5a\", \"views_perftests\": \"1f8ac341e42cf943b25363ebb64acefaab202319\", \"views_unittests\": \"8c46799ad8eb566383f7c3026e293e364543928d\", \"viz_unittests\": \"ce6da597fc547de0548af492342a716a81e69347\", \"vr_common_unittests\": \"a902a61df484652f4307a5569a1a256890d8168c\", \"vr_pixeltests\": \"443cbfd7c85d305f10ca83ffa89e309080269ee1\", \"webdriver_wpt_tests\": \"97f5af3a82a64b7d73afef3687d31c3ce61ca688\", \"weblayer_browsertests\": \"82220d7656711d90d430402bc0665e14c99efeae\", \"weblayer_unittests\": \"8c3d99a7126ce23562d0a4d51818d10362faca40\", \"wm_unittests\": \"0abade672fa3c7da6a8d78a594b123330c1cbee5\", \"wtf_unittests\": \"e4d460a8be2cd6bf9b4c36cef50180f3248a93b0\", \"x11_unittests\": \"1623ce8d5af870dcce03dfb7e48e7ec265159406\", \"xr_browser_tests\": \"7d24dd37a3f1d4ed1cf2399f030a01b865d67bc7\", \"zlib_unittests\": \"b090341fe0d32d806eb60597269da30a0375af02\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1f79602663d9ad088e67440e285ce3aa4e667ee6079f6847203831e9639d7662_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_be71ec2e45ff41f29ecdc3611cfb7c276cc0ff3138424d653aa2b7cfb51218d3_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-149-4156\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615545519322766",
"status": "COMPLETED",
"status_changed_ts": "1615548808867526",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181330",
"builder:Linux Builder (dbg)",
"buildset:commit/git/abd32d7284c10d14dfbe6c6da0be3118d98170c5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abd32d7284c10d14dfbe6c6da0be3118d98170c5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018401525030723680",
"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/8852971463011384320/+/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:523ed5c3476f8810",
"user_agent:luci-scheduler"
],
"updated_ts": "1615548808889367",
"url": "https://ci.chromium.org/b/8852971463011384320",
"utcnow_ts": "1615548809679181"
}
}
[11:33:29.698] Invocation finished in 54m56.951147315s with status SUCCEEDED