[01:13:26.205] New invocation is queued and will start shortly
[01:13:27.638] Starting the invocation (attempt 1)
[01:13:27.717] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:13:27.717] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:13:27.717] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051686165310106000",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"efe949175f326f0bc0a6b9f96e8a3601ce87fdc2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051686165310106000",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/efe949175f326f0bc0a6b9f96e8a3601ce87fdc2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/efe949175f326f0bc0a6b9f96e8a3601ce87fdc2",
"gitiles_ref:refs/heads/master"
]
}
[01:13:28.685] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583802807826629",
"id": "8886256102939274400",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"efe949175f326f0bc0a6b9f96e8a3601ce87fdc2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583802808419845",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169545",
"builder:Linux Builder (dbg)",
"buildset:commit/git/efe949175f326f0bc0a6b9f96e8a3601ce87fdc2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/efe949175f326f0bc0a6b9f96e8a3601ce87fdc2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051686165310106000",
"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/8886256102939274400/+/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": "1583802808419952",
"url": "https://ci.chromium.org/b/8886256102939274400",
"utcnow_ts": "1583802808678291"
}
}
[01:13:28.685] Task URL: https://ci.chromium.org/b/8886256102939274400
[01:13:28.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:2:0) after 1m0s
[01:14:29.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:2:0)
[01:14:29.045] Timer tick, asking Buildbucket for the build status
[01:14:29.200] Build 8886256102939274400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:29.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:3:0) after 1m0s
[01:15:29.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:3:0)
[01:15:29.434] Timer tick, asking Buildbucket for the build status
[01:15:29.519] Build 8886256102939274400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:29.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:4:0) after 1m0s
[01:16:29.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:4:0)
[01:16:29.702] Timer tick, asking Buildbucket for the build status
[01:16:29.784] Build 8886256102939274400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:29.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:5:0) after 1m0s
[01:17:30.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:5:0)
[01:17:30.079] Timer tick, asking Buildbucket for the build status
[01:17:30.347] Build 8886256102939274400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:30.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:6:0) after 1m0s
[01:18:16.972] Received PubSub notification, asking Buildbucket for the build status
[01:18:17.057] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:30.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:6:0)
[01:18:30.356] Timer tick, asking Buildbucket for the build status
[01:18:30.416] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:30.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:8:0) after 1m0s
[01:19:30.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:8:0)
[01:19:30.542] Timer tick, asking Buildbucket for the build status
[01:19:30.653] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:30.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:9:0) after 1m0s
[01:20:30.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:9:0)
[01:20:30.872] Timer tick, asking Buildbucket for the build status
[01:20:31.169] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:31.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:10:0) after 1m0s
[01:21:31.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:10:0)
[01:21:31.300] Timer tick, asking Buildbucket for the build status
[01:21:31.476] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:31.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:11:0) after 1m0s
[01:22:31.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:11:0)
[01:22:31.578] Timer tick, asking Buildbucket for the build status
[01:22:31.796] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:31.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:12:0) after 1m0s
[01:23:31.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:12:0)
[01:23:31.919] Timer tick, asking Buildbucket for the build status
[01:23:32.000] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:32.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:13:0) after 1m0s
[01:24:32.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:13:0)
[01:24:32.059] Timer tick, asking Buildbucket for the build status
[01:24:32.225] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:32.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:14:0) after 1m0s
[01:25:32.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:14:0)
[01:25:32.334] Timer tick, asking Buildbucket for the build status
[01:25:32.499] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:32.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:15:0) after 1m0s
[01:26:32.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:15:0)
[01:26:32.591] Timer tick, asking Buildbucket for the build status
[01:26:32.937] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:32.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:16:0) after 1m0s
[01:27:32.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:16:0)
[01:27:32.972] Timer tick, asking Buildbucket for the build status
[01:27:33.157] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:33.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:17:0) after 1m0s
[01:28:33.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:17:0)
[01:28:33.184] Timer tick, asking Buildbucket for the build status
[01:28:33.306] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:33.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:18:0) after 1m0s
[01:29:33.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:18:0)
[01:29:33.438] Timer tick, asking Buildbucket for the build status
[01:29:33.744] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:33.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:19:0) after 1m0s
[01:30:33.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:19:0)
[01:30:33.778] Timer tick, asking Buildbucket for the build status
[01:30:33.909] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:33.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:20:0) after 1m0s
[01:31:33.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:20:0)
[01:31:33.991] Timer tick, asking Buildbucket for the build status
[01:31:34.163] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:34.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:21:0) after 1m0s
[01:32:36.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:21:0)
[01:32:36.015] Timer tick, asking Buildbucket for the build status
[01:32:36.241] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:36.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:22:0) after 1m0s
[01:33:36.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:22:0)
[01:33:36.467] Timer tick, asking Buildbucket for the build status
[01:33:36.820] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:36.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:23:0) after 1m0s
[01:34:37.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:23:0)
[01:34:37.045] Timer tick, asking Buildbucket for the build status
[01:34:37.152] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:37.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:24:0) after 1m0s
[01:35:37.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:24:0)
[01:35:37.207] Timer tick, asking Buildbucket for the build status
[01:35:37.532] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:37.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:25:0) after 1m0s
[01:36:37.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:25:0)
[01:36:37.609] Timer tick, asking Buildbucket for the build status
[01:36:37.717] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:37.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:26:0) after 1m0s
[01:37:37.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:26:0)
[01:37:37.884] Timer tick, asking Buildbucket for the build status
[01:37:38.155] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:38.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:27:0) after 1m0s
[01:38:38.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:27:0)
[01:38:38.411] Timer tick, asking Buildbucket for the build status
[01:38:38.805] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:38.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:28:0) after 1m0s
[01:39:38.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:28:0)
[01:39:38.923] Timer tick, asking Buildbucket for the build status
[01:39:39.113] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:39.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:29:0) after 1m0s
[01:40:39.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:29:0)
[01:40:39.231] Timer tick, asking Buildbucket for the build status
[01:40:39.416] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:39.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:30:0) after 1m0s
[01:41:39.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:30:0)
[01:41:39.711] Timer tick, asking Buildbucket for the build status
[01:41:40.302] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:40.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:31:0) after 1m0s
[01:42:40.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:31:0)
[01:42:40.423] Timer tick, asking Buildbucket for the build status
[01:42:40.589] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:40.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:32:0) after 1m0s
[01:43:40.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:32:0)
[01:43:40.741] Timer tick, asking Buildbucket for the build status
[01:43:40.875] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:40.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:33:0) after 1m0s
[01:44:40.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:33:0)
[01:44:40.919] Timer tick, asking Buildbucket for the build status
[01:44:41.061] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:41.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:34:0) after 1m0s
[01:45:41.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:34:0)
[01:45:41.291] Timer tick, asking Buildbucket for the build status
[01:45:41.393] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:41.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:35:0) after 1m0s
[01:46:41.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:35:0)
[01:46:41.514] Timer tick, asking Buildbucket for the build status
[01:46:41.629] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:41.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:36:0) after 1m0s
[01:47:41.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:36:0)
[01:47:41.749] Timer tick, asking Buildbucket for the build status
[01:47:42.166] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:42.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:37:0) after 1m0s
[01:48:42.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:37:0)
[01:48:42.231] Timer tick, asking Buildbucket for the build status
[01:48:42.558] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:42.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:38:0) after 1m0s
[01:49:42.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:38:0)
[01:49:42.649] Timer tick, asking Buildbucket for the build status
[01:49:42.803] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:42.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:39:0) after 1m0s
[01:50:42.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:39:0)
[01:50:42.942] Timer tick, asking Buildbucket for the build status
[01:50:43.126] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:43.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:40:0) after 1m0s
[01:51:43.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:40:0)
[01:51:43.135] Timer tick, asking Buildbucket for the build status
[01:51:43.234] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:43.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:41:0) after 1m0s
[01:52:43.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:41:0)
[01:52:43.348] Timer tick, asking Buildbucket for the build status
[01:52:43.517] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:43.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:42:0) after 1m0s
[01:53:43.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:42:0)
[01:53:43.560] Timer tick, asking Buildbucket for the build status
[01:53:43.693] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:43.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:43:0) after 1m0s
[01:54:43.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:43:0)
[01:54:43.800] Timer tick, asking Buildbucket for the build status
[01:54:43.915] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:43.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:44:0) after 1m0s
[01:55:43.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:44:0)
[01:55:43.933] Timer tick, asking Buildbucket for the build status
[01:55:44.172] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:44.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:45:0) after 1m0s
[01:56:44.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:45:0)
[01:56:44.191] Timer tick, asking Buildbucket for the build status
[01:56:44.341] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:44.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:46:0) after 1m0s
[01:57:44.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:46:0)
[01:57:44.427] Timer tick, asking Buildbucket for the build status
[01:57:44.548] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:44.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:47:0) after 1m0s
[01:58:44.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:47:0)
[01:58:44.581] Timer tick, asking Buildbucket for the build status
[01:58:44.884] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:44.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:48:0) after 1m0s
[01:59:44.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:48:0)
[01:59:44.956] Timer tick, asking Buildbucket for the build status
[01:59:45.045] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:49:0) after 1m0s
[02:00:45.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:49:0)
[02:00:45.144] Timer tick, asking Buildbucket for the build status
[02:00:45.264] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:45.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:50:0) after 1m0s
[02:01:45.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:50:0)
[02:01:45.357] Timer tick, asking Buildbucket for the build status
[02:01:45.447] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:45.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:51:0) after 1m0s
[02:02:45.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:51:0)
[02:02:45.467] Timer tick, asking Buildbucket for the build status
[02:02:45.594] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:52:0) after 1m0s
[02:03:45.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:52:0)
[02:03:45.650] Timer tick, asking Buildbucket for the build status
[02:03:45.952] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:45.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:53:0) after 1m0s
[02:04:46.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:53:0)
[02:04:46.032] Timer tick, asking Buildbucket for the build status
[02:04:46.140] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:46.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:54:0) after 1m0s
[02:05:46.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:54:0)
[02:05:46.258] Timer tick, asking Buildbucket for the build status
[02:05:46.498] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:46.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:55:0) after 1m0s
[02:06:46.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:55:0)
[02:06:46.607] Timer tick, asking Buildbucket for the build status
[02:06:46.713] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:56:0) after 1m0s
[02:07:46.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:56:0)
[02:07:46.812] Timer tick, asking Buildbucket for the build status
[02:07:47.007] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:47.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:57:0) after 1m0s
[02:08:46.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:57:0)
[02:08:46.983] Timer tick, asking Buildbucket for the build status
[02:08:47.265] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:47.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:58:0) after 1m0s
[02:09:47.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:58:0)
[02:09:47.490] Timer tick, asking Buildbucket for the build status
[02:09:47.620] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:47.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:59:0) after 1m0s
[02:10:47.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:59:0)
[02:10:47.701] Timer tick, asking Buildbucket for the build status
[02:10:48.249] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:48.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:60:0) after 1m0s
[02:11:48.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:60:0)
[02:11:48.308] Timer tick, asking Buildbucket for the build status
[02:11:48.716] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:48.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:61:0) after 1m0s
[02:12:48.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:61:0)
[02:12:48.809] Timer tick, asking Buildbucket for the build status
[02:12:48.944] Build 8886256102939274400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051686165310106000:62:0) after 1m0s
[02:13:23.347] Received PubSub notification, asking Buildbucket for the build status
[02:13:23.430] Build 8886256102939274400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:13:23.430] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583806402315495",
"created_by": "project:chromium",
"created_ts": "1583802807826629",
"id": "8886256102939274400",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"efe949175f326f0bc0a6b9f96e8a3601ce87fdc2\"}}",
"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-57-vknc\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169545, \"got_angle_revision\": \"c2d817317046b06c86aaf9c9c133c728cc7915f4\", \"got_dawn_revision\": \"be6cd5188880a1f5a80e70eb240ec9bad7e05348\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"efe949175f326f0bc0a6b9f96e8a3601ce87fdc2\", \"got_revision_cp\": \"refs/heads/master@{#748472}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8be72df6046231eedbd14d155a5a9484bda217c1\", \"got_v8_revision\": \"34d7ff92f5bd05783e6c40f2ca3dc629bec7fb46\", \"got_v8_revision_cp\": \"refs/heads/8.2.276@{#1}\", \"got_webrtc_revision\": \"a1ac244222a54e34444efd33335f4058fbd5ca46\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30731}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"efe949175f326f0bc0a6b9f96e8a3601ce87fdc2\", \"swarm_hashes_refs/heads/master(at){#748472}_without_patch\": {\"accessibility_unittests\": \"ac7d667c7a61818df560eb6ca8c843fac7646afd\", \"angle_unittests\": \"c2ea2227e56b0fe2cdc39f357049f293592d54fa\", \"app_shell_unittests\": \"1fa92cf8c385e5a10f99867564e0a8c264ec73ce\", \"aura_unittests\": \"7b9b9e88bc2fb34edf3e0eb68a375a90a69eb6c9\", \"base_unittests\": \"fc8e06c3fd1cb06da84eb9c69f2e3cde6f72d24b\", \"base_util_unittests\": \"6ab1bc43ac739d9f85dc154da9cc49b1d0d9ded0\", \"blink_common_unittests\": \"614f1f3b1eb0f57a3976ee790a63121b3d6b4b15\", \"blink_fuzzer_unittests\": \"9052cf7c98d1ff1be06ad6c14ddf59d139009722\", \"blink_heap_unittests\": \"b50005fe9741c305b94a7a0f325e743f2c6eac84\", \"blink_platform_unittests\": \"3c4f242e398170a71206c4d40a994aa728ebbd2c\", \"blink_python_tests\": \"d96ce9e301b45ede5205e7ac660f3c47b575dbb1\", \"blink_unittests\": \"196162c07a85caa208a8ef1241c26834ef116339\", \"blink_web_tests\": \"709f15c2834810a2f1792e8907cb1668c6b179a1\", \"boringssl_crypto_tests\": \"7fa30bcbc20e20d18e8cdd043eb0aa4b53a1b3ec\", \"boringssl_ssl_tests\": \"5780e7da2397eb22a29edecc475fdb25f8525c3c\", \"browser_tests\": \"70cfa2a50069c13bc5aef5442e8f022219cf0ab8\", \"cacheinvalidation_unittests\": \"c5e05f2296e0319009bd8e5554257779c0d6ed05\", \"capture_unittests\": \"9d96a798f78b0c60738936702cf8f203d5fb9cc5\", \"cast_unittests\": \"910907954dee33d4d072a79995de48e44b83f1b3\", \"cc_unittests\": \"6f68a68769b343947806c0b1d0df6fdfb80945b1\", \"chrome_app_unittests\": \"154448906bae77e011d36b882318ceb9827190bc\", \"chromedriver_unittests\": \"b6c710c945b3f72466bebc829126569e0f9f8825\", \"components_browsertests\": \"f4d59b3646541d15f7f9801a19567296e579f6c6\", \"components_unittests\": \"a37c582fa9a3db01946046801805cf12dd77a22e\", \"compositor_unittests\": \"de85c84dd177134709d55e12b68009fd3a665b66\", \"content_browsertests\": \"4fda214f408de99744e3aa16c92d23dfa68b5b60\", \"content_shell_crash_test\": \"2c2372787f1fd53edd20f485878de95d247fa42c\", \"content_unittests\": \"02947d9f3d324df48648e6d186dcb271e50dd815\", \"crashpad_tests\": \"3d07eaa4320f7b9f199040666e7c7d302cbbf204\", \"cronet_tests\": \"6d7c1cf9aa5e5e4d8dd1b8d3b1a98c010afe6a08\", \"cronet_unittests\": \"93a23a25ad7c0c550ebbcd39ca096722c8c46416\", \"crypto_unittests\": \"b1a3d1024914c72239c6ca11813fbbc4ecb29903\", \"dbus_unittests\": \"94c0f1b5bf76feeb0fd32f73bae8d4aac128289a\", \"device_unittests\": \"b580e94603efd5f114b110918789a77cc5e41bc9\", \"display_unittests\": \"bc6d634e91a2c413124138aa33f015b91ca5609e\", \"events_unittests\": \"c0f9c26d99be30956cf0490861059647da9a791c\", \"extensions_browsertests\": \"7e73fa6df5b33294ee67bdb7396965362c16598b\", \"extensions_unittests\": \"97d8ece389c8554948cec470a6b0f3f87a0f1f4e\", \"filesystem_service_unittests\": \"9f5a87b15b1e3e23dec4450a1e75fc4a041417b6\", \"flatbuffers_unittests\": \"050844e0d26621703adfe93dfd2f97054fb85d6c\", \"gcm_unit_tests\": \"7006363185ba5f7d8a75c367c6eb008ae752ba98\", \"gfx_unittests\": \"1be8cac4dad1d5bcfbf267b132dea139bbe7da5e\", \"gin_unittests\": \"4f947b5cb83a87581ff5c78467f703edcdf7cecb\", \"google_apis_unittests\": \"b96ad50579e07d1a80d8e3cd71a966e3726a6514\", \"gpu_unittests\": \"5b5c8ba8f2ee812967338d43a7ebb851debc6874\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"9a5d9cd630c31fb41587dc6a46f186a091f9f9d1\", \"headless_browsertests\": \"d313de26d4822aefd9167342f85359365860dc56\", \"headless_unittests\": \"9949692a35798280db0b9db94b32473f887011a4\", \"interactive_ui_tests\": \"10abc4b017bee30f45151abb042705997abb4608\", \"ipc_tests\": \"ce283208cc06cff9b0fa59c4d73140ed34fc2c6e\", \"jingle_unittests\": \"cbdee3165f37af1bb28f777b93a65dae81e90246\", \"latency_unittests\": \"9fc5f10a15da594b973e55a53e0695998c33717b\", \"libjingle_xmpp_unittests\": \"2d3dd1aa44f77a145c79590e5ca494250d672f48\", \"media_blink_unittests\": \"96c20ec523850e0b0faea292dbb91c67df492b84\", \"media_service_unittests\": \"8ce6dd315ac3785d5e563da73a77262d729674cc\", \"media_unittests\": \"319b621215890cc3c76d7c452ebd8f75557fc1b0\", \"message_center_unittests\": \"a008876606cbbdb7ff246965b9fc3d3a0145713b\", \"metrics_python_tests\": \"cfd8eaf51ca4affa81b777816702571924d11076\", \"midi_unittests\": \"12c7e3bb0dc14a8a826387ed20b4470ccb859dc1\", \"mojo_core_unittests\": \"4fd3120641cf3e92a399a31d0b3fd8793aec5f7d\", \"mojo_unittests\": \"46791a18f8e36272103aa1e628308953bf38d012\", \"nacl_helper_nonsfi_unittests\": \"140ba3cf7fa2e62112573d0404aa619a0a11b62d\", \"nacl_loader_unittests\": \"0e0e3f914ca6dff16adb0f9e4405c38ecb9f4460\", \"native_theme_unittests\": \"95a142809aed5c60f3d405f130545ff313459fe8\", \"net_unittests\": \"aab7ff64c7396bfbf72155bdb10876af19a68db0\", \"pdf_unittests\": \"cdd8f67c09ec782f175462b631fe2c179b53bf45\", \"perfetto_unittests\": \"8d4578244fd7a61c4011d511e49f8006333d2afa\", \"ppapi_unittests\": \"47b62356c8f5acebddf07bd596826162ca01f044\", \"printing_unittests\": \"f580e023eb6a5c61ad18ec1eff249d3dc4282436\", \"remoting_unittests\": \"8354f2250a0bf4272f7604a9fd15d5da4f36e46a\", \"sandbox_linux_unittests\": \"e02369ea7003a4eed47244acf85cd5a35d7a0191\", \"service_manager_unittests\": \"de086ca3a647d313c8941f41ae82e9eaadf0d0a4\", \"services_unittests\": \"0cd125c08665dcf836fc7a2f5f0f7874d667d71f\", \"shell_dialogs_unittests\": \"3e4981509916117a2e5697618205329285297c69\", \"skia_unittests\": \"0298102f98ae3f6ab2bfbb105f411f1a88e50ce6\", \"snapshot_unittests\": \"c98ce9488f48a67d9bd1ccc55e59ea1de8758976\", \"sql_unittests\": \"e6c5173e8adfacf6ac42b58c7e85a9430629cce3\", \"storage_unittests\": \"a4c5bcf8516c3e2a593df08c095537b8630e51f5\", \"sync_integration_tests\": \"edef1df85633e2d0755ad783e07c6935a7113cf6\", \"telemetry_gpu_unittests\": \"38b607095c84cf2aa43bb4069f9dcbd407bd285a\", \"telemetry_perf_unittests\": \"a09d6443c54e1998b5807a446de2edb6ed0df711\", \"telemetry_unittests\": \"3a54252b5a1f121b00d8890b456cd5625b5c5daa\", \"traffic_annotation_auditor_unittests\": \"a611417b9cac490087092265507339feafd2d933\", \"ui_base_unittests\": \"15ec5853e5bc98ad5087ab13bffdd638e750ccf0\", \"ui_touch_selection_unittests\": \"32c44492a5c871db33870d85825bc47d8e0cbcb0\", \"unit_tests\": \"96d5a2e7347d96b683f5c7c4e47c058282eda2e8\", \"url_unittests\": \"4cdf4a9f073e00bc0c76449e33d1dfac60e9f3e6\", \"views_perftests\": \"e3ced8ee54565f6f75140aa4afe4ef69dda86ee1\", \"views_unittests\": \"9196e94a7e63eb964f089caadabab89a8f2fbad6\", \"viz_unittests\": \"561047016b47dd90461a67ceabec24c08fd6b3e6\", \"vr_common_unittests\": \"961de8d8741f6273d716e846bd5123cec1081874\", \"vr_pixeltests\": \"875e4a6b5894c6b0bb08b26a518d17cc903c912e\", \"webdriver_wpt_tests\": \"54b78b19ec05c42622b4469c7a3e6ade9680258d\", \"weblayer_browsertests\": \"bf743ddd35e0b0a7a5c082d7ee89ff69a24b88a9\", \"wm_unittests\": \"0d3690915fd5f8db2b84f1659add2ce1ba04f15e\", \"wtf_unittests\": \"68cfc68752bf511098c1b1c49e4a631aa6e9c7ee\", \"xr_browser_tests\": \"253b84c372c5b45fa3dd69e933b01186ede3ecc8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_8116c80c2882afcd67a910417bbd6fba6f94de5911d922ccd599199b9d07f827_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_a2762fc34916ccddaf93df3ba974050968da64cd82521aaf473d97885fea8846_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-57-vknc\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583803096167401",
"status": "COMPLETED",
"status_changed_ts": "1583806402708396",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169545",
"builder:Linux Builder (dbg)",
"buildset:commit/git/efe949175f326f0bc0a6b9f96e8a3601ce87fdc2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/efe949175f326f0bc0a6b9f96e8a3601ce87fdc2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051686165310106000",
"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/8886256102939274400/+/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:4adad283ba0ac810",
"user_agent:luci-scheduler"
],
"updated_ts": "1583806402744416",
"url": "https://ci.chromium.org/b/8886256102939274400",
"utcnow_ts": "1583806403422135"
}
}
[02:13:23.430] Invocation finished in 59m57.248998417s with status SUCCEEDED