[05:55:14.447] New invocation is queued and will start shortly
[05:55:15.704] Starting the invocation (attempt 1)
[05:55:15.735] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:55:15.737] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:55:15.737] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025757703334849856",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f5a1084622d0f4e20cd0dfc85aeab833472deaf4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025757703334849856",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f5a1084622d0f4e20cd0dfc85aeab833472deaf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f5a1084622d0f4e20cd0dfc85aeab833472deaf4",
"gitiles_ref:refs/heads/master"
]
}
[05:55:18.362] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608530115982209",
"id": "8860327641062702896",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f5a1084622d0f4e20cd0dfc85aeab833472deaf4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608530117582951",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178860",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f5a1084622d0f4e20cd0dfc85aeab833472deaf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f5a1084622d0f4e20cd0dfc85aeab833472deaf4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025757703334849856",
"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/8860327641062702896/+/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": "1608530117583208",
"url": "https://ci.chromium.org/b/8860327641062702896",
"utcnow_ts": "1608530117791694"
}
}
[05:55:18.362] Task URL: https://ci.chromium.org/b/8860327641062702896
[05:55:18.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:2:0) after 1m0s
[05:55:23.092] Received PubSub notification, asking Buildbucket for the build status
[05:55:23.200] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:18.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:2:0)
[05:56:18.379] Timer tick, asking Buildbucket for the build status
[05:56:18.661] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:18.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:4:0) after 1m0s
[05:57:18.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:4:0)
[05:57:18.724] Timer tick, asking Buildbucket for the build status
[05:57:18.776] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:18.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:5:0) after 1m0s
[05:58:18.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:5:0)
[05:58:18.792] Timer tick, asking Buildbucket for the build status
[05:58:19.273] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:19.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:6:0) after 1m0s
[05:59:19.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:6:0)
[05:59:19.299] Timer tick, asking Buildbucket for the build status
[05:59:19.383] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:19.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:7:0) after 1m0s
[06:00:19.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:7:0)
[06:00:19.412] Timer tick, asking Buildbucket for the build status
[06:00:19.558] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:19.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:8:0) after 1m0s
[06:01:27.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:8:0)
[06:01:27.903] Timer tick, asking Buildbucket for the build status
[06:01:27.985] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:27.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:9:0) after 1m0s
[06:02:28.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:9:0)
[06:02:28.033] Timer tick, asking Buildbucket for the build status
[06:02:28.094] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:28.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:10:0) after 1m0s
[06:03:28.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:10:0)
[06:03:28.149] Timer tick, asking Buildbucket for the build status
[06:03:28.208] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:28.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:11:0) after 1m0s
[06:04:28.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:11:0)
[06:04:28.213] Timer tick, asking Buildbucket for the build status
[06:04:28.296] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:28.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:12:0) after 1m0s
[06:05:28.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:12:0)
[06:05:28.334] Timer tick, asking Buildbucket for the build status
[06:05:28.488] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:28.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:13:0) after 1m0s
[06:06:28.567] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:13:0)
[06:06:28.568] Timer tick, asking Buildbucket for the build status
[06:06:28.642] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:28.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:14:0) after 1m0s
[06:07:28.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:14:0)
[06:07:28.722] Timer tick, asking Buildbucket for the build status
[06:07:28.783] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:28.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:15:0) after 1m0s
[06:08:28.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:15:0)
[06:08:28.862] Timer tick, asking Buildbucket for the build status
[06:08:28.924] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:28.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:16:0) after 1m0s
[06:09:28.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:16:0)
[06:09:28.933] Timer tick, asking Buildbucket for the build status
[06:09:29.062] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:29.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:17:0) after 1m0s
[06:10:29.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:17:0)
[06:10:29.053] Timer tick, asking Buildbucket for the build status
[06:10:29.174] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:29.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:18:0) after 1m0s
[06:11:29.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:18:0)
[06:11:29.199] Timer tick, asking Buildbucket for the build status
[06:11:29.283] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:29.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:19:0) after 1m0s
[06:12:29.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:19:0)
[06:12:29.327] Timer tick, asking Buildbucket for the build status
[06:12:29.551] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:29.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:20:0) after 1m0s
[06:13:29.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:20:0)
[06:13:29.689] Timer tick, asking Buildbucket for the build status
[06:13:29.763] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:29.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:21:0) after 1m0s
[06:14:29.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:21:0)
[06:14:29.843] Timer tick, asking Buildbucket for the build status
[06:14:29.904] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:29.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:22:0) after 1m0s
[06:15:30.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:22:0)
[06:15:30.112] Timer tick, asking Buildbucket for the build status
[06:15:30.237] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:30.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:23:0) after 1m0s
[06:16:30.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:23:0)
[06:16:30.291] Timer tick, asking Buildbucket for the build status
[06:16:30.358] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:30.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:24:0) after 1m0s
[06:17:30.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:24:0)
[06:17:30.467] Timer tick, asking Buildbucket for the build status
[06:17:30.548] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:30.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:25:0) after 1m0s
[06:18:30.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:25:0)
[06:18:30.673] Timer tick, asking Buildbucket for the build status
[06:18:30.795] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:30.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:26:0) after 1m0s
[06:19:30.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:26:0)
[06:19:30.869] Timer tick, asking Buildbucket for the build status
[06:19:30.950] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:30.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:27:0) after 1m0s
[06:20:30.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:27:0)
[06:20:30.969] Timer tick, asking Buildbucket for the build status
[06:20:31.130] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:31.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:28:0) after 1m0s
[06:21:31.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:28:0)
[06:21:31.114] Timer tick, asking Buildbucket for the build status
[06:21:31.178] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:31.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:29:0) after 1m0s
[06:22:31.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:29:0)
[06:22:31.173] Timer tick, asking Buildbucket for the build status
[06:22:31.242] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:31.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:30:0) after 1m0s
[06:23:31.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:30:0)
[06:23:31.258] Timer tick, asking Buildbucket for the build status
[06:23:31.324] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:31.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:31:0) after 1m0s
[06:24:31.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:31:0)
[06:24:31.310] Timer tick, asking Buildbucket for the build status
[06:24:31.359] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:31.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:32:0) after 1m0s
[06:25:31.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:32:0)
[06:25:31.432] Timer tick, asking Buildbucket for the build status
[06:25:31.530] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:31.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:33:0) after 1m0s
[06:26:31.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:33:0)
[06:26:31.632] Timer tick, asking Buildbucket for the build status
[06:26:31.769] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:31.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:34:0) after 1m0s
[06:27:31.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:34:0)
[06:27:31.786] Timer tick, asking Buildbucket for the build status
[06:27:31.841] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:31.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:35:0) after 1m0s
[06:28:31.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:35:0)
[06:28:31.878] Timer tick, asking Buildbucket for the build status
[06:28:31.976] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:31.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:36:0) after 1m0s
[06:29:32.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:36:0)
[06:29:32.034] Timer tick, asking Buildbucket for the build status
[06:29:32.118] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:32.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:37:0) after 1m0s
[06:30:32.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:37:0)
[06:30:32.147] Timer tick, asking Buildbucket for the build status
[06:30:32.468] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:32.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:38:0) after 1m0s
[06:31:32.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:38:0)
[06:31:32.488] Timer tick, asking Buildbucket for the build status
[06:31:32.667] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:32.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:39:0) after 1m0s
[06:32:32.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:39:0)
[06:32:32.698] Timer tick, asking Buildbucket for the build status
[06:32:32.924] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:32.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:40:0) after 1m0s
[06:33:32.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:40:0)
[06:33:32.972] Timer tick, asking Buildbucket for the build status
[06:33:33.143] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:33.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:41:0) after 1m0s
[06:34:33.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:41:0)
[06:34:33.131] Timer tick, asking Buildbucket for the build status
[06:34:33.286] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:33.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:42:0) after 1m0s
[06:35:33.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:42:0)
[06:35:33.333] Timer tick, asking Buildbucket for the build status
[06:35:33.426] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:33.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:43:0) after 1m0s
[06:36:33.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:43:0)
[06:36:33.464] Timer tick, asking Buildbucket for the build status
[06:36:33.528] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:33.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:44:0) after 1m0s
[06:37:33.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:44:0)
[06:37:33.550] Timer tick, asking Buildbucket for the build status
[06:37:33.615] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:33.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:45:0) after 1m0s
[06:38:33.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:45:0)
[06:38:33.635] Timer tick, asking Buildbucket for the build status
[06:38:33.696] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:33.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:46:0) after 1m0s
[06:39:33.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:46:0)
[06:39:33.716] Timer tick, asking Buildbucket for the build status
[06:39:33.780] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:33.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:47:0) after 1m0s
[06:40:33.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:47:0)
[06:40:33.800] Timer tick, asking Buildbucket for the build status
[06:40:34.163] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:34.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:48:0) after 1m0s
[06:41:34.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:48:0)
[06:41:34.187] Timer tick, asking Buildbucket for the build status
[06:41:34.596] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:34.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:49:0) after 1m0s
[06:42:34.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:49:0)
[06:42:34.614] Timer tick, asking Buildbucket for the build status
[06:42:34.716] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:34.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:50:0) after 1m0s
[06:43:34.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:50:0)
[06:43:34.771] Timer tick, asking Buildbucket for the build status
[06:43:37.255] Build 8860327641062702896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:37.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025757703334849856:51:0) after 1m0s
[06:43:59.568] Received PubSub notification, asking Buildbucket for the build status
[06:43:59.901] Build 8860327641062702896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:43:59.901] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608533038860117",
"created_by": "project:chromium",
"created_ts": "1608530115982209",
"id": "8860327641062702896",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f5a1084622d0f4e20cd0dfc85aeab833472deaf4\"}}",
"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\": \"f5a1084622d0f4e20cd0dfc85aeab833472deaf4\", \"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-140-s2j7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178860, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"f5a1084622d0f4e20cd0dfc85aeab833472deaf4\", \"got_revision_cp\": \"refs/heads/master@{#838601}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"73bf5d7db9ade92643424d79b47ac70900843225\", \"got_v8_revision_cp\": \"refs/heads/8.9.178@{#1}\", \"got_webrtc_revision\": \"ef9c4e07a351c9396c72e72efaa1be3df728c440\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32863}\", \"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\": \"f5a1084622d0f4e20cd0dfc85aeab833472deaf4\", \"swarm_hashes_refs/heads/master(at){#838601}_without_patch\": {\"absl_hardening_tests\": \"5b23c832c920ec541323eec2f066ddb54ce58905\", \"accessibility_unittests\": \"ffb53161c3450e64c126cd4ea312eda88004a9a4\", \"angle_unittests\": \"8df4e8f15c1e32758569f49e0271c0fb98d827df\", \"app_shell_unittests\": \"3918e32738e9fa3b9935a7fdb063d71002cc7f82\", \"aura_unittests\": \"156689643aa4daa73e870b8c8c7c3f4362cd40aa\", \"base_unittests\": \"70043c3e4924524a02275d38d150f4490c922b28\", \"base_util_unittests\": \"38e4e1c665306f62753c1859315e99d5113ef47c\", \"blink_common_unittests\": \"8b5617313d70f9f25d405ac77d70330d0fba784d\", \"blink_fuzzer_unittests\": \"8154dcbf343ac5daba4b3c32f4dc08d7707410e6\", \"blink_heap_unittests\": \"7a6479b4bfd671f7705ab50689beb845f932674d\", \"blink_platform_unittests\": \"daf628cd0e00a49efa7a00540a5916df799722bc\", \"blink_python_tests\": \"413a3fec3803575adbb1ebb947c6444ab6634018\", \"blink_unittests\": \"8cb79cdb113ea0ef4e963cd765509e16f94dfb66\", \"blink_web_tests\": \"0d12ec365879eea5fc8d7d1681dc3349507da950\", \"boringssl_crypto_tests\": \"fd7093b63f66e04108ef047af1c9ecb4c37225be\", \"boringssl_ssl_tests\": \"7c892ebff847d6f823a9ac62b6089e79a6e32555\", \"browser_tests\": \"cd7047603be1446211dd81e5679def15a374d1f7\", \"capture_unittests\": \"4fea7f4e2117669c869e950c856377bc9ecfab4f\", \"cast_unittests\": \"9914a7a218133a289cc78eabd82dcf4e706a77ec\", \"cc_unittests\": \"7215e5f5bb07cc770f86449201632b2d5f585132\", \"chrome_app_unittests\": \"1fa739c01e8c94cf04285b8799548a1f9cd1ddb6\", \"chromedriver_unittests\": \"b2df57415bd5c537ce7c52e7c517b5e4764b1062\", \"components_browsertests\": \"010d9356e8ed083441c2ae0fec2ba351343e45cc\", \"components_unittests\": \"553dda7f193c999b5413e6d62f044ab1de7243d4\", \"compositor_unittests\": \"2adbbfaa125101a85dbbb7633532d1ab752c7e34\", \"content_browsertests\": \"025a93bfafb8c4db12108125cdce1d4bfb60d12c\", \"content_shell_crash_test\": \"d67e5acc72ed5abfc855dc904167cbeddb730c99\", \"content_unittests\": \"dd6b3915dd4b5d27b7d99298407d754f8e4c6b0f\", \"crashpad_tests\": \"f098db5cd55148eb073c435294238268cbc12259\", \"cronet_tests\": \"1dd14f66d08075d1dad26d54abf552c31a62b657\", \"cronet_unittests\": \"08cc9e540c6a3eb709ef19c97dad662ade18d6e3\", \"crypto_unittests\": \"0b957c8094b22a07a39c0710052c29f4f5412073\", \"dbus_unittests\": \"98bcdc60a3581c3743c67b70ba9402691f1cb4ca\", \"device_unittests\": \"8fd839ce0591e3866e187cd2574a05829c49753e\", \"display_unittests\": \"41c7d9de8aba3de56108cdaf127ca35ac3e84222\", \"events_unittests\": \"14688caaae9d113e67ca9708f881f22acd2afaa0\", \"extension_docserver_python_unittests\": \"9008142ff021b59f2939eb6b6ca1258c23237347\", \"extensions_browsertests\": \"26d18ddcd27e9047047714e32f27c5ef66f7c26c\", \"extensions_unittests\": \"de29a61f7b6c23b1ccbced4875e27af7ad752f02\", \"filesystem_service_unittests\": \"92fc25a0683e000b6e943cf02e3fec8baab5c60d\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"1b4ac095a0323a567eb0d894235f8ef92f08af00\", \"gfx_unittests\": \"f4ca28705c3f71c35d3c26ed11d37b32ab114b8a\", \"gin_unittests\": \"509e5981fd2c2ecae44858b4c9870115ca5031e9\", \"google_apis_unittests\": \"21ee37bb301790683569e20075a5930577cb169c\", \"gpu_unittests\": \"64987f1009091b0a0f0aa0f28629fb291048c7f4\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"65f269765d39bf6bc2938993cadb6460ff99096b\", \"headless_browsertests\": \"5e6482fd16e0ee05dfbd12a8c7c468ea807a9752\", \"headless_unittests\": \"773928316e61ba208950adbd6eb3730efd744032\", \"interactive_ui_tests\": \"e8d23e454f07975795b1a423b3e827e595382ef0\", \"ipc_tests\": \"3809db4eacad6856a8921b94423e9ebc0f533831\", \"jingle_unittests\": \"dc872ebeece13d4ed52a22b37823604d8cc8aff4\", \"latency_unittests\": \"2e29fad33401ee6b1fc1cb2872f499fec73657a5\", \"libjingle_xmpp_unittests\": \"932f87ace76dda5c292409840b08b543ecddd67c\", \"liburlpattern_unittests\": \"df69acc4d612bc91d96e1aff04942ac2bfceab4b\", \"media_blink_unittests\": \"96dffc57ea9cfea841babf0339ebf3da1714e89b\", \"media_unittests\": \"ce6bdb6f2ef3a646c28f441a5a762f504ac03f22\", \"message_center_unittests\": \"b3b859bd0b17f1562ec3703f525a7229d60161fc\", \"metrics_python_tests\": \"1d40a21ac8cafa16ace0adccffff1d8a0b8109b7\", \"midi_unittests\": \"1b18ee2b24d3589d360a92e519cfbf4f30ad8d6b\", \"mojo_core_unittests\": \"02cd1901fdae20e18dc24b6c1dc47ad4af6440df\", \"mojo_unittests\": \"8bed1e1c5c8bcddc194e3b5ef4e9c552ae3c7af5\", \"nacl_helper_nonsfi_unittests\": \"739edf0d0f701dfef93edb173b11433f82378370\", \"nacl_loader_unittests\": \"9cb7fb7201589662b9dc8f030f4ba56e6d010f4d\", \"native_theme_unittests\": \"9ee5eff947dccd48d2bb314d5513cc89562e4b3c\", \"net_unittests\": \"f1094c92679beee89538201eb1538196505ebc85\", \"openscreen_unittests\": \"5248314535cf4a63fab4bb1ca11a9529723d34b8\", \"pdf_unittests\": \"310e8718037d3059e0750d9e1a84b29c289b2096\", \"perfetto_unittests\": \"d24e742e4fd5347e4eca09cf273a6ca911b544a0\", \"ppapi_unittests\": \"c495429b280c9469150e337f74b17a290adf3f8b\", \"printing_unittests\": \"14c18bba3ebda62e7d34cc1119d43df63d4552f3\", \"remoting_unittests\": \"4961e0d4cf1cb851dc735164ad8b5712d0d3aa13\", \"sandbox_linux_unittests\": \"330c03509535f58f0b46e916f512b81bf4b71fb6\", \"service_manager_unittests\": \"8b562fc0c8fd9807c6fb533efc9fbbee4c19813a\", \"services_unittests\": \"3e107a356c09a32d6c648e628a90caeeebdcd864\", \"shell_dialogs_unittests\": \"9f1bd292d07f22334cc534577410cae3a018fcef\", \"skia_unittests\": \"16a4d0b592ac222ab1fe86903b95d2359d679012\", \"snapshot_unittests\": \"0fd72cdfd1cada3f18bee875178d8d078561f670\", \"sql_unittests\": \"60547df750142218ceb63250c2e8c5a5da38f023\", \"storage_unittests\": \"f7a6376be9fe4fc379cce821fced47388141b6ca\", \"sync_integration_tests\": \"c333cb478a7af114f06e2862ec645aac20a20b45\", \"telemetry_gpu_unittests\": \"80f628a812675587c2762f4045ff5635bdc79bdd\", \"telemetry_perf_unittests\": \"765a357f6375b312cdbc1cb99495b8c0bbca9c24\", \"telemetry_unittests\": \"267c8bb88015ff39701ecd9c4f8883f68f696271\", \"traffic_annotation_auditor_unittests\": \"8d47e7a54e543a13f535d8bb6a698e70dcaeb1f6\", \"ui_base_unittests\": \"7cc1df6ee0eb9baca65c2a48df35a83b8e056f2a\", \"ui_touch_selection_unittests\": \"0dd8c64a45539ab6bd6c39b22ab06444033906bc\", \"unit_tests\": \"892b0c7854fbc711af276e69734415f75e939aac\", \"url_unittests\": \"6cb2afe4f2d24c9f2ccacdd95631a1eeef4da02f\", \"views_perftests\": \"f967f1374399ffa03a6b2d9295b5071cca94fd0f\", \"views_unittests\": \"46115a8fff23a3fcd2f1281f5b76cbba5e6b8616\", \"viz_unittests\": \"47ce12a61a503d3152f3aa7ad7b611e952759dce\", \"vr_common_unittests\": \"861b69e4bd1a5476ca6f0bf8c0047201195d9b9d\", \"vr_pixeltests\": \"e73c74054350297f74795b8d1d9c86fb7c418b0e\", \"webdriver_wpt_tests\": \"44d5248f823dc01ec23b60c87eb8c11e99ffe114\", \"weblayer_browsertests\": \"4dbfe54152c4ee7393e681c653353d673cd9ac05\", \"weblayer_unittests\": \"cb900199358fe10c147f8143328efb893d3f86d7\", \"wm_unittests\": \"f5aaa58d06e4180a01c24e479b81162665758cee\", \"wtf_unittests\": \"10ce9adc91dda05af5e745719ee09383cf171543\", \"x11_unittests\": \"7b6d48e5ce96158048f1cc4828761b3d18fc7f59\", \"xr_browser_tests\": \"858e89915728b921b05e82c08026bf43f3c86efd\", \"zlib_unittests\": \"6d9d72e65d124fbff133afa1f01e2de5ac3f432a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-140-s2j7\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608530122388131",
"status": "COMPLETED",
"status_changed_ts": "1608533039179360",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178860",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f5a1084622d0f4e20cd0dfc85aeab833472deaf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f5a1084622d0f4e20cd0dfc85aeab833472deaf4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025757703334849856",
"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/8860327641062702896/+/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:509caf5370140110",
"user_agent:luci-scheduler"
],
"updated_ts": "1608533039183633",
"url": "https://ci.chromium.org/b/8860327641062702896",
"utcnow_ts": "1608533039884207"
}
}
[06:43:59.901] Invocation finished in 48m45.470168285s with status SUCCEEDED