[19:49:16.440] New invocation is queued and will start shortly
[19:49:17.813] Starting the invocation (attempt 1)
[19:49:17.857] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:49:17.857] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:49:17.857] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058410735376399200",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"82b8caf536444e56c455c32acbf77b1e69e9dc14\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9058410735376399200",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/82b8caf536444e56c455c32acbf77b1e69e9dc14",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b8caf536444e56c455c32acbf77b1e69e9dc14",
"gitiles_ref:refs/heads/master"
]
}
[19:49:18.731] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577389757997861",
"id": "8892980673076355920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82b8caf536444e56c455c32acbf77b1e69e9dc14\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577389758461965",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166609",
"builder:Linux Builder (dbg)",
"buildset:commit/git/82b8caf536444e56c455c32acbf77b1e69e9dc14",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b8caf536444e56c455c32acbf77b1e69e9dc14",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058410735376399200",
"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/8892980673076355920/+/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": "1577389758462095",
"url": "https://ci.chromium.org/b/8892980673076355920",
"utcnow_ts": "1577389758721530"
}
}
[19:49:18.731] Task URL: https://ci.chromium.org/b/8892980673076355920
[19:49:18.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:2:0) after 1m0s
[19:50:18.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:2:0)
[19:50:18.867] Timer tick, asking Buildbucket for the build status
[19:50:19.265] Build 8892980673076355920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:19.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:3:0) after 1m0s
[19:51:19.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:3:0)
[19:51:19.335] Timer tick, asking Buildbucket for the build status
[19:51:19.571] Build 8892980673076355920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:19.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:4:0) after 1m0s
[19:52:19.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:4:0)
[19:52:19.596] Timer tick, asking Buildbucket for the build status
[19:52:19.840] Build 8892980673076355920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:19.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:5:0) after 1m0s
[19:53:19.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:5:0)
[19:53:19.858] Timer tick, asking Buildbucket for the build status
[19:53:20.036] Build 8892980673076355920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:20.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:6:0) after 1m0s
[19:54:06.416] Received PubSub notification, asking Buildbucket for the build status
[19:54:07.033] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:20.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:6:0)
[19:54:20.062] Timer tick, asking Buildbucket for the build status
[19:54:20.314] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:20.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:8:0) after 1m0s
[19:55:20.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:8:0)
[19:55:20.350] Timer tick, asking Buildbucket for the build status
[19:55:20.528] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:20.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:9:0) after 1m0s
[19:56:20.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:9:0)
[19:56:20.571] Timer tick, asking Buildbucket for the build status
[19:56:20.988] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:20.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:10:0) after 1m0s
[19:57:21.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:10:0)
[19:57:21.014] Timer tick, asking Buildbucket for the build status
[19:57:21.679] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:21.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:11:0) after 1m0s
[19:58:21.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:11:0)
[19:58:21.696] Timer tick, asking Buildbucket for the build status
[19:58:21.903] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:21.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:12:0) after 1m0s
[19:59:21.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:12:0)
[19:59:21.973] Timer tick, asking Buildbucket for the build status
[19:59:22.254] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:22.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:13:0) after 1m0s
[20:00:22.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:13:0)
[20:00:22.771] Timer tick, asking Buildbucket for the build status
[20:00:22.916] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:22.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:14:0) after 1m0s
[20:01:23.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:14:0)
[20:01:23.130] Timer tick, asking Buildbucket for the build status
[20:01:23.461] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:23.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:15:0) after 1m0s
[20:02:23.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:15:0)
[20:02:23.644] Timer tick, asking Buildbucket for the build status
[20:02:23.879] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:23.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:16:0) after 1m0s
[20:03:24.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:16:0)
[20:03:24.209] Timer tick, asking Buildbucket for the build status
[20:03:24.355] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:24.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:17:0) after 1m0s
[20:04:25.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:17:0)
[20:04:25.068] Timer tick, asking Buildbucket for the build status
[20:04:25.301] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:25.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:18:0) after 1m0s
[20:05:27.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:18:0)
[20:05:27.396] Timer tick, asking Buildbucket for the build status
[20:05:27.558] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:27.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:19:0) after 1m0s
[20:06:28.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:19:0)
[20:06:28.111] Timer tick, asking Buildbucket for the build status
[20:06:28.309] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:28.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:20:0) after 1m0s
[20:07:28.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:20:0)
[20:07:28.454] Timer tick, asking Buildbucket for the build status
[20:07:31.437] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:31.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:21:0) after 1m0s
[20:08:31.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:21:0)
[20:08:31.681] Timer tick, asking Buildbucket for the build status
[20:08:31.937] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:31.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:22:0) after 1m0s
[20:09:32.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:22:0)
[20:09:32.213] Timer tick, asking Buildbucket for the build status
[20:09:32.633] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:32.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:23:0) after 1m0s
[20:10:32.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:23:0)
[20:10:32.776] Timer tick, asking Buildbucket for the build status
[20:10:33.067] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:33.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:24:0) after 1m0s
[20:11:33.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:24:0)
[20:11:33.158] Timer tick, asking Buildbucket for the build status
[20:11:33.313] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:33.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:25:0) after 1m0s
[20:12:33.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:25:0)
[20:12:33.333] Timer tick, asking Buildbucket for the build status
[20:12:33.862] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:33.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:26:0) after 1m0s
[20:13:33.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:26:0)
[20:13:33.947] Timer tick, asking Buildbucket for the build status
[20:13:34.208] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:34.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:27:0) after 1m0s
[20:14:34.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:27:0)
[20:14:34.224] Timer tick, asking Buildbucket for the build status
[20:14:34.414] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:34.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:28:0) after 1m0s
[20:15:34.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:28:0)
[20:15:34.520] Timer tick, asking Buildbucket for the build status
[20:15:34.820] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:34.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:29:0) after 1m0s
[20:16:34.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:29:0)
[20:16:34.847] Timer tick, asking Buildbucket for the build status
[20:16:35.657] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:35.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:30:0) after 1m0s
[20:17:35.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:30:0)
[20:17:35.745] Timer tick, asking Buildbucket for the build status
[20:17:35.906] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:35.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:31:0) after 1m0s
[20:18:35.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:31:0)
[20:18:35.945] Timer tick, asking Buildbucket for the build status
[20:18:36.137] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:36.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:32:0) after 1m0s
[20:19:36.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:32:0)
[20:19:36.281] Timer tick, asking Buildbucket for the build status
[20:19:36.463] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:36.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:33:0) after 1m0s
[20:20:36.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:33:0)
[20:20:36.488] Timer tick, asking Buildbucket for the build status
[20:20:36.906] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:36.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:34:0) after 1m0s
[20:21:36.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:34:0)
[20:21:36.954] Timer tick, asking Buildbucket for the build status
[20:21:37.286] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:37.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:35:0) after 1m0s
[20:22:37.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:35:0)
[20:22:37.323] Timer tick, asking Buildbucket for the build status
[20:22:37.519] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:37.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:36:0) after 1m0s
[20:23:37.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:36:0)
[20:23:37.608] Timer tick, asking Buildbucket for the build status
[20:23:38.196] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:38.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:37:0) after 1m0s
[20:24:38.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:37:0)
[20:24:38.224] Timer tick, asking Buildbucket for the build status
[20:24:38.613] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:38.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:38:0) after 1m0s
[20:25:38.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:38:0)
[20:25:38.698] Timer tick, asking Buildbucket for the build status
[20:25:38.896] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:38.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:39:0) after 1m0s
[20:26:38.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:39:0)
[20:26:38.979] Timer tick, asking Buildbucket for the build status
[20:26:39.137] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:39.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:40:0) after 1m0s
[20:27:39.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:40:0)
[20:27:39.194] Timer tick, asking Buildbucket for the build status
[20:27:39.391] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:39.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:41:0) after 1m0s
[20:28:39.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:41:0)
[20:28:39.437] Timer tick, asking Buildbucket for the build status
[20:28:40.183] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:40.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:42:0) after 1m0s
[20:29:40.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:42:0)
[20:29:40.204] Timer tick, asking Buildbucket for the build status
[20:29:40.365] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:40.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:43:0) after 1m0s
[20:30:40.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:43:0)
[20:30:40.432] Timer tick, asking Buildbucket for the build status
[20:30:40.620] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:40.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:44:0) after 1m0s
[20:31:40.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:44:0)
[20:31:40.642] Timer tick, asking Buildbucket for the build status
[20:31:40.865] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:40.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:45:0) after 1m0s
[20:32:40.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:45:0)
[20:32:40.901] Timer tick, asking Buildbucket for the build status
[20:32:41.356] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:41.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:46:0) after 1m0s
[20:33:41.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:46:0)
[20:33:41.387] Timer tick, asking Buildbucket for the build status
[20:33:41.644] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:41.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:47:0) after 1m0s
[20:34:41.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:47:0)
[20:34:41.669] Timer tick, asking Buildbucket for the build status
[20:34:42.660] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:42.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:48:0) after 1m0s
[20:35:42.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:48:0)
[20:35:42.688] Timer tick, asking Buildbucket for the build status
[20:35:42.890] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:42.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:49:0) after 1m0s
[20:36:42.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:49:0)
[20:36:42.952] Timer tick, asking Buildbucket for the build status
[20:36:43.105] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:43.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:50:0) after 1m0s
[20:37:43.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:50:0)
[20:37:43.111] Timer tick, asking Buildbucket for the build status
[20:37:44.261] Build 8892980673076355920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:44.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058410735376399200:51:0) after 1m0s
[20:38:42.753] Received PubSub notification, asking Buildbucket for the build status
[20:38:43.178] Build 8892980673076355920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:38:43.178] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577392718555071",
"created_by": "project:chromium",
"created_ts": "1577389757997861",
"id": "8892980673076355920",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82b8caf536444e56c455c32acbf77b1e69e9dc14\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-98-uhfd\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166609, \"got_angle_revision\": \"01dd6f6ca430a5c5bfd9d237b5569abd835694fc\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"82b8caf536444e56c455c32acbf77b1e69e9dc14\", \"got_revision_cp\": \"refs/heads/master@{#727480}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6e3a387c01598240a7a8722ab8cbd1015ec1cd0a\", \"got_v8_revision\": \"53366c4eab3aa7def56310d7cbafc23c33179bc6\", \"got_v8_revision_cp\": \"refs/heads/8.1.75@{#1}\", \"got_webrtc_revision\": \"26762d0425ffd15af9ddc3ae669373668827ea00\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30125}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82b8caf536444e56c455c32acbf77b1e69e9dc14\", \"swarm_hashes_refs/heads/master(at){#727480}_without_patch\": {\"accessibility_unittests\": \"549365e90115cc0dae379a5ff12fc21201102416\", \"angle_unittests\": \"4f6864b7956efe2e8d1846ec0a314d847d35e9b1\", \"app_shell_unittests\": \"d7c242d9d3621dea4238d1eff5adf1b24af4ed16\", \"aura_unittests\": \"3bbd41262e18eefbed162e1c1d23b960749cd477\", \"base_unittests\": \"5df7688d7c9719816869c1b824006dbac29f95ec\", \"base_util_unittests\": \"0df9370fa5d798ea032a6eba290a8aa66632aff7\", \"blink_common_unittests\": \"4820459c71d07cb23c9b2cc2807e66b515039ec1\", \"blink_fuzzer_unittests\": \"08f1cdc5bc6cd5e6fc38002dcb20970f517536c1\", \"blink_heap_unittests\": \"8d0bcd594d554da3d5559da41a434d426685a2dd\", \"blink_platform_unittests\": \"ade59cb556729f9af6f97aa5c0ca9c65528f9f0a\", \"blink_python_tests\": \"e3ab48cc253ed8191dfa2591ea6e2b5382fb90fd\", \"blink_unittests\": \"13bc404cd1d4c53e4f6e96dcaed13121cb788db6\", \"blink_web_tests\": \"450376af59436e5277602377c36ce6ee59f102a8\", \"boringssl_crypto_tests\": \"d5ee27370b765d1b8841eec2c897223ba713a9fd\", \"boringssl_ssl_tests\": \"9068614d6371f901eca99c2e47a55c53cfe48889\", \"browser_tests\": \"ec31df46618cc9704de8f9ca295a83f5c2805b4f\", \"cacheinvalidation_unittests\": \"2824919316cba1f74f15bb797bbaa86aedd30e7a\", \"capture_unittests\": \"f485d6b85f551adf2e95d42cefce34b6b792ec6f\", \"cast_unittests\": \"3d10c38987c5399e34f6f3d2aa4df1cc84e5d54e\", \"cc_unittests\": \"ab567a7c5b022d7a0be820d42379df0530fb3807\", \"chrome_app_unittests\": \"a0b80bc27c7cf500f6213f9eec16d96dfac5355f\", \"chromedriver_unittests\": \"3b78daf1e1fb91f0d19cd88499e26e57cfcb23b9\", \"components_browsertests\": \"91a416c492874c03c8a0dc295d088db381638eed\", \"components_unittests\": \"2b90c156d3cb8accaef53f10cfeb33d805288a0b\", \"compositor_unittests\": \"b80e011937cc8a341c49d26ca3b1b9820a973600\", \"content_browsertests\": \"d3f2c13e03bc3d9c7c5a850cddd039ee45170582\", \"content_shell_crash_test\": \"9bcb6f375d629a9fa555641f6fbc722dde64d996\", \"content_unittests\": \"1f52636939a41ea1f6ab881413948116ab7efab8\", \"crashpad_tests\": \"ccc9f4fdaf39f3524daf060f179397eb9218e474\", \"cronet_tests\": \"6fdaf953c230c44bf83b7840958e66e9cd6b509b\", \"cronet_unittests\": \"eb44cbd76da4be32232fab1cbedcd3b5e600da65\", \"crypto_unittests\": \"a65ec25a716e7b0fe81869a60746741c8cd66140\", \"dbus_unittests\": \"f0018d7e01d6ecb1125ab810953758e99e9ca795\", \"device_unittests\": \"ec8ae23a3f61a523c94e7923b3063d899a0d5a76\", \"devtools_lint_check\": \"f5ef4bbd5230ceca8e6b62aa06ad4d93f07aaee9\", \"devtools_type_check\": \"0560d4eae584ad288c2a1900ea29c456fa9b4b3b\", \"display_unittests\": \"a3ddcaf6d50b9ace7479f793c3180d047458dfd7\", \"events_unittests\": \"841e53244775930fa1acc9beaaa4e1f979558a34\", \"extensions_browsertests\": \"51c85c6c1553b5b6344f4fa1f2e3e7cb0be40df0\", \"extensions_unittests\": \"14dee844133421ef6cc4a40b0736e7ae58ee2640\", \"filesystem_service_unittests\": \"32e04201da4bfef3287259d687bce1284907e9dc\", \"flatbuffers_unittests\": \"35d92a748edf43f648bd80c0c655e609f5a52216\", \"gcm_unit_tests\": \"0fbf4e90b6c029581b17eb078a574bf61fd8fec8\", \"gfx_unittests\": \"acd45db3e4f0dc04917c846ee7600b86630b7512\", \"gin_unittests\": \"11239c66e172474601704bef92c7a6fc9375bbd1\", \"google_apis_unittests\": \"1af2fb55120892306739ddbea4aebeb2c158b99e\", \"gpu_unittests\": \"2592cbc20ba3fd83946a883c66a7efe35661ca75\", \"grit_python_unittests\": \"92a851f89811e715f33e61624f055bd6c7226997\", \"gwp_asan_unittests\": \"9a6edee672ab972a43770c3faf1f5a0fdc7693a0\", \"headless_browsertests\": \"d9efdd8c342d5f94f26fbf4805ee630f4b104a36\", \"headless_unittests\": \"87e7bbff1623fba8b6c72b2c076bf9327d636f95\", \"interactive_ui_tests\": \"66a3394705dd3ae1073492530914dee237cb7121\", \"ipc_tests\": \"295b219fbc4ea7eab14fb8e17e6cfe909c3c4493\", \"jingle_unittests\": \"998464fcd256041d6b0a62831d0e034774bdfe60\", \"latency_unittests\": \"ad7c345213d253d1fc2c393d11ec71c073197e56\", \"libjingle_xmpp_unittests\": \"7b33aaf23dd6da3ac5bad3dd71176f2507b1d0be\", \"media_blink_unittests\": \"2d5a68dd7b0b7902070650a1403a350f2a1ee2a9\", \"media_service_unittests\": \"8f9f6e616ca095a6c2d7ebeef36b3c08a61f5c40\", \"media_unittests\": \"8e7a49dfdb00b2883df57b84d741f8a3cf8fd24f\", \"message_center_unittests\": \"f8a2558413381c603bb1dc945c85151ae4b2955d\", \"metrics_python_tests\": \"59cf26718a324a20a72bfecf989de09a4cdea39e\", \"midi_unittests\": \"a5ab3bff8bec8ef1f7e8f759dbf65a45b5af975f\", \"mojo_core_unittests\": \"970802ed1e72eb3260c0d2b6299d4ed65fc07351\", \"mojo_unittests\": \"cc04a79f0278e4b65aad7edc35c72ebf627a31fc\", \"nacl_helper_nonsfi_unittests\": \"34c7aae2b7d5ec9cde6e85a78b6a0d47d1175759\", \"nacl_loader_unittests\": \"3742e173de9c072c079c81dbaeb73b2f3bc8ed35\", \"native_theme_unittests\": \"f8f68a5240d99287377714d31be1057011daa5ec\", \"net_unittests\": \"2f12c79a44ef12bf23e39153929125a426b38372\", \"pdf_unittests\": \"84f769bcb14b8f76c3e9837ed7fbc59915039a07\", \"perfetto_unittests\": \"001418ce632502d37e98b9f34feef3fda617b38e\", \"ppapi_unittests\": \"45150e7180469af036fc8a5333546ffe974b84bf\", \"printing_unittests\": \"08957bd1c4a2b67683ee51587d16d22048b12d07\", \"remoting_unittests\": \"f5e487a7c80232e010243d6af954a068256c3417\", \"sandbox_linux_unittests\": \"284b273d1210f7b8c324d3f0da1151bfe71a8acc\", \"service_manager_unittests\": \"f43429229c246dae57baffa162ff9835ffb02acc\", \"services_unittests\": \"519c5647ee36c5ff8ff4d29859b70179c731a592\", \"shell_dialogs_unittests\": \"9b3e650ec7d8def961f2951e59cc9170824ee7ad\", \"skia_unittests\": \"68b13139a73794d95950e5f4d34e29d435670e92\", \"snapshot_unittests\": \"27c2cd7cfa798e81ac9a4d1be8cd0d23581616f4\", \"sql_unittests\": \"fe641a557b2f70a9f4bbeb7199e0c2d4a6b064f6\", \"storage_unittests\": \"17dc454055809b1d5ac426f364aaac69825a8594\", \"sync_integration_tests\": \"f3a0e18d4226cd519dc444fccff83bd87570c275\", \"telemetry_gpu_unittests\": \"7e197790b3f5b9274216c4dbd5b4e8e05e6b946c\", \"telemetry_perf_unittests\": \"b71df95948e4c22bf1fed5afa4083006f7f4341e\", \"telemetry_unittests\": \"3abd49972a4ebc2daa4fc2148774b40a78868df3\", \"traffic_annotation_auditor_unittests\": \"8fbf7b544bfe529da387a7d6641ed7c190864d89\", \"ui_base_unittests\": \"854f1dc8309b914198e15ba82461c549aa49b194\", \"ui_touch_selection_unittests\": \"32981416c4c229dec839a109498f5524ef9796a4\", \"unit_tests\": \"a1dbfa6f8ccea8236408a2ba3b0d355abcbb6f53\", \"url_unittests\": \"036bebd50fc4b19e93f97204f53855189d2f7103\", \"views_perftests\": \"252b131bb35640ce7669d536fdcce54e821c0d4e\", \"views_unittests\": \"97cd0598e40f1408405228d23a4b5c88066ab278\", \"viz_unittests\": \"011785940e8c96a199ad8f24a63b887085d8f64c\", \"vr_common_unittests\": \"1fe2519a8fce711cf7b2cba1aabe6469d8724f16\", \"vr_pixeltests\": \"eef59378c7e5bba44154916f1a31b97a9cfc0748\", \"webdriver_wpt_tests\": \"497ac9f92d0e2a98ec05dd206979bc54c211cdca\", \"weblayer_browsertests\": \"ff1aca2ff04b69f563d6ed3274cde94e8f22ec11\", \"wm_unittests\": \"06f433cd64cb678fa67a5be3dad0bed6004aa110\", \"wtf_unittests\": \"e5eec54b6b7a75dc16eb5a0f376c4b93c5911458\", \"xr_browser_tests\": \"e845220fa301747d408445cf0dd9622dcf0033db\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1f6efd1a63ab00e2ded981a0276806cd2aaf7978081f3ef44b6752422059bb79_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-98-uhfd\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577390045585186",
"status": "COMPLETED",
"status_changed_ts": "1577392721733975",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166609",
"builder:Linux Builder (dbg)",
"buildset:commit/git/82b8caf536444e56c455c32acbf77b1e69e9dc14",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b8caf536444e56c455c32acbf77b1e69e9dc14",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058410735376399200",
"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/8892980673076355920/+/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:495c932298a11510",
"user_agent:luci-scheduler"
],
"updated_ts": "1577392721846844",
"url": "https://ci.chromium.org/b/8892980673076355920",
"utcnow_ts": "1577392723166213"
}
}
[20:38:43.178] Invocation finished in 49m26.757265576s with status SUCCEEDED