[16:00:26.085] New invocation is queued and will start shortly
[16:00:27.166] Starting the invocation (attempt 1)
[16:00:27.213] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:00:27.213] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:00:27.213] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023817091528752432",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6d39c7ae321ce077cc13d6e1e068ab2272ad49fe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9023817091528752432",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6d39c7ae321ce077cc13d6e1e068ab2272ad49fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d39c7ae321ce077cc13d6e1e068ab2272ad49fe",
"gitiles_ref:refs/heads/master"
]
}
[16:00:29.199] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610380827335095",
"id": "8858387029554401824",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6d39c7ae321ce077cc13d6e1e068ab2272ad49fe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610380828542478",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179532",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6d39c7ae321ce077cc13d6e1e068ab2272ad49fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d39c7ae321ce077cc13d6e1e068ab2272ad49fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023817091528752432",
"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/8858387029554401824/+/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": "1610380828542648",
"url": "https://ci.chromium.org/b/8858387029554401824",
"utcnow_ts": "1610380829127406"
}
}
[16:00:29.199] Task URL: https://ci.chromium.org/b/8858387029554401824
[16:00:29.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:2:0) after 1m0s
[16:00:30.987] Received PubSub notification, asking Buildbucket for the build status
[16:00:31.103] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:29.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:2:0)
[16:01:29.320] Timer tick, asking Buildbucket for the build status
[16:01:30.331] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:4:0) after 1m0s
[16:02:30.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:4:0)
[16:02:30.360] Timer tick, asking Buildbucket for the build status
[16:02:30.443] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:30.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:5:0) after 1m0s
[16:03:30.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:5:0)
[16:03:30.479] Timer tick, asking Buildbucket for the build status
[16:03:30.810] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:30.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:6:0) after 1m0s
[16:04:30.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:6:0)
[16:04:30.951] Timer tick, asking Buildbucket for the build status
[16:04:33.620] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:33.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:7:0) after 1m0s
[16:05:33.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:7:0)
[16:05:33.674] Timer tick, asking Buildbucket for the build status
[16:05:33.827] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:33.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:8:0) after 1m0s
[16:06:34.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:8:0)
[16:06:34.036] Timer tick, asking Buildbucket for the build status
[16:06:34.094] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:34.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:9:0) after 1m0s
[16:07:34.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:9:0)
[16:07:34.167] Timer tick, asking Buildbucket for the build status
[16:07:34.266] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:34.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:10:0) after 1m0s
[16:08:34.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:10:0)
[16:08:34.400] Timer tick, asking Buildbucket for the build status
[16:08:34.471] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:34.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:11:0) after 1m0s
[16:09:34.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:11:0)
[16:09:34.558] Timer tick, asking Buildbucket for the build status
[16:09:34.803] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:34.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:12:0) after 1m0s
[16:10:34.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:12:0)
[16:10:34.852] Timer tick, asking Buildbucket for the build status
[16:10:35.361] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:35.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:13:0) after 1m0s
[16:11:35.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:13:0)
[16:11:35.430] Timer tick, asking Buildbucket for the build status
[16:11:35.538] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:35.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:14:0) after 1m0s
[16:12:35.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:14:0)
[16:12:35.558] Timer tick, asking Buildbucket for the build status
[16:12:35.653] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:35.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:15:0) after 1m0s
[16:13:35.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:15:0)
[16:13:35.690] Timer tick, asking Buildbucket for the build status
[16:13:35.847] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:35.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:16:0) after 1m0s
[16:14:35.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:16:0)
[16:14:35.892] Timer tick, asking Buildbucket for the build status
[16:14:35.961] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:35.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:17:0) after 1m0s
[16:15:36.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:17:0)
[16:15:36.015] Timer tick, asking Buildbucket for the build status
[16:15:36.146] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:36.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:18:0) after 1m0s
[16:16:36.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:18:0)
[16:16:36.165] Timer tick, asking Buildbucket for the build status
[16:16:36.273] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:36.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:19:0) after 1m0s
[16:17:36.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:19:0)
[16:17:36.297] Timer tick, asking Buildbucket for the build status
[16:17:36.379] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:36.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:20:0) after 1m0s
[16:18:36.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:20:0)
[16:18:36.411] Timer tick, asking Buildbucket for the build status
[16:18:36.495] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:36.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:21:0) after 1m0s
[16:19:36.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:21:0)
[16:19:36.516] Timer tick, asking Buildbucket for the build status
[16:19:36.984] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:36.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:22:0) after 1m0s
[16:20:37.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:22:0)
[16:20:37.000] Timer tick, asking Buildbucket for the build status
[16:20:37.169] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:37.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:23:0) after 1m0s
[16:21:37.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:23:0)
[16:21:37.159] Timer tick, asking Buildbucket for the build status
[16:21:37.246] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:37.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:24:0) after 1m0s
[16:22:37.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:24:0)
[16:22:37.426] Timer tick, asking Buildbucket for the build status
[16:22:37.529] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:37.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:25:0) after 1m0s
[16:23:37.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:25:0)
[16:23:37.750] Timer tick, asking Buildbucket for the build status
[16:23:38.356] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:38.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:26:0) after 1m0s
[16:24:38.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:26:0)
[16:24:38.448] Timer tick, asking Buildbucket for the build status
[16:24:38.513] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:38.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:27:0) after 1m0s
[16:25:38.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:27:0)
[16:25:38.547] Timer tick, asking Buildbucket for the build status
[16:25:38.724] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:38.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:28:0) after 1m0s
[16:26:38.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:28:0)
[16:26:38.796] Timer tick, asking Buildbucket for the build status
[16:26:38.851] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:38.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:29:0) after 1m0s
[16:27:38.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:29:0)
[16:27:38.926] Timer tick, asking Buildbucket for the build status
[16:27:39.115] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:39.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:30:0) after 1m0s
[16:28:39.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:30:0)
[16:28:39.243] Timer tick, asking Buildbucket for the build status
[16:28:39.498] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:39.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:31:0) after 1m0s
[16:29:39.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:31:0)
[16:29:39.578] Timer tick, asking Buildbucket for the build status
[16:29:39.639] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:39.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:32:0) after 1m0s
[16:30:39.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:32:0)
[16:30:39.663] Timer tick, asking Buildbucket for the build status
[16:30:39.851] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:39.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:33:0) after 1m0s
[16:31:39.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:33:0)
[16:31:39.895] Timer tick, asking Buildbucket for the build status
[16:31:39.969] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:39.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:34:0) after 1m0s
[16:32:39.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:34:0)
[16:32:39.996] Timer tick, asking Buildbucket for the build status
[16:32:40.099] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:40.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:35:0) after 1m0s
[16:33:40.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:35:0)
[16:33:40.164] Timer tick, asking Buildbucket for the build status
[16:33:40.228] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:40.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:36:0) after 1m0s
[16:34:40.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:36:0)
[16:34:40.238] Timer tick, asking Buildbucket for the build status
[16:34:40.351] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:40.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:37:0) after 1m0s
[16:35:40.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:37:0)
[16:35:40.398] Timer tick, asking Buildbucket for the build status
[16:35:40.511] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:40.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:38:0) after 1m0s
[16:36:40.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:38:0)
[16:36:40.555] Timer tick, asking Buildbucket for the build status
[16:36:40.645] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:40.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:39:0) after 1m0s
[16:37:40.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:39:0)
[16:37:40.790] Timer tick, asking Buildbucket for the build status
[16:37:40.976] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:40.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:40:0) after 1m0s
[16:38:40.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:40:0)
[16:38:40.978] Timer tick, asking Buildbucket for the build status
[16:38:41.122] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:41.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:41:0) after 1m0s
[16:39:41.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:41:0)
[16:39:41.158] Timer tick, asking Buildbucket for the build status
[16:39:41.296] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:41.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:42:0) after 1m0s
[16:40:41.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:42:0)
[16:40:41.300] Timer tick, asking Buildbucket for the build status
[16:40:41.445] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:41.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:43:0) after 1m0s
[16:41:41.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:43:0)
[16:41:41.522] Timer tick, asking Buildbucket for the build status
[16:41:41.589] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:41.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:44:0) after 1m0s
[16:42:41.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:44:0)
[16:42:41.657] Timer tick, asking Buildbucket for the build status
[16:42:41.764] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:41.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:45:0) after 1m0s
[16:43:41.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:45:0)
[16:43:41.926] Timer tick, asking Buildbucket for the build status
[16:43:42.002] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:42.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:46:0) after 1m0s
[16:44:42.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:46:0)
[16:44:42.180] Timer tick, asking Buildbucket for the build status
[16:44:42.253] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:42.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:47:0) after 1m0s
[16:45:42.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:47:0)
[16:45:42.324] Timer tick, asking Buildbucket for the build status
[16:45:42.488] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:42.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:48:0) after 1m0s
[16:46:42.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:48:0)
[16:46:42.677] Timer tick, asking Buildbucket for the build status
[16:46:43.290] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:43.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:49:0) after 1m0s
[16:47:43.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:49:0)
[16:47:43.371] Timer tick, asking Buildbucket for the build status
[16:47:43.511] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:43.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:50:0) after 1m0s
[16:48:43.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:50:0)
[16:48:43.607] Timer tick, asking Buildbucket for the build status
[16:48:44.364] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:44.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:51:0) after 1m0s
[16:49:44.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:51:0)
[16:49:44.435] Timer tick, asking Buildbucket for the build status
[16:49:44.852] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:44.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:52:0) after 1m0s
[16:50:44.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:52:0)
[16:50:44.901] Timer tick, asking Buildbucket for the build status
[16:50:45.298] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:45.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:53:0) after 1m0s
[16:51:45.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:53:0)
[16:51:45.326] Timer tick, asking Buildbucket for the build status
[16:51:45.417] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:45.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:54:0) after 1m0s
[16:52:45.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:54:0)
[16:52:45.505] Timer tick, asking Buildbucket for the build status
[16:52:45.760] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:45.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:55:0) after 1m0s
[16:53:45.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:55:0)
[16:53:45.827] Timer tick, asking Buildbucket for the build status
[16:53:46.157] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:46.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:56:0) after 1m0s
[16:54:46.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:56:0)
[16:54:46.216] Timer tick, asking Buildbucket for the build status
[16:54:46.333] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:46.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:57:0) after 1m0s
[16:55:46.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:57:0)
[16:55:46.368] Timer tick, asking Buildbucket for the build status
[16:55:46.595] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:46.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:58:0) after 1m0s
[16:56:46.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:58:0)
[16:56:46.691] Timer tick, asking Buildbucket for the build status
[16:56:46.753] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:46.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:59:0) after 1m0s
[16:57:46.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:59:0)
[16:57:46.856] Timer tick, asking Buildbucket for the build status
[16:57:47.039] Build 8858387029554401824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:47.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9023817091528752432:60:0) after 1m0s
[16:58:33.903] Received PubSub notification, asking Buildbucket for the build status
[16:58:34.020] Build 8858387029554401824: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:58:34.020] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610384313032392",
"created_by": "project:chromium",
"created_ts": "1610380827335095",
"id": "8858387029554401824",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6d39c7ae321ce077cc13d6e1e068ab2272ad49fe\"}}",
"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\": \"6d39c7ae321ce077cc13d6e1e068ab2272ad49fe\", \"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-128-r3v6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179532, \"got_angle_revision\": \"c600e47812c88d45087582122dbb004851ae966b\", \"got_dawn_revision\": \"1670c5184b9eca52aac58636723e13e4d20fda75\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"6d39c7ae321ce077cc13d6e1e068ab2272ad49fe\", \"got_revision_cp\": \"refs/heads/master@{#842052}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"cfaba5184b58dddef979661ea5c17ac1a00d2a48\", \"got_v8_revision_cp\": \"refs/heads/8.9.232@{#1}\", \"got_webrtc_revision\": \"cffaf0aea477b2ec923d023ef4a8b1bf65921cab\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32933}\", \"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\": \"6d39c7ae321ce077cc13d6e1e068ab2272ad49fe\", \"swarm_hashes_refs/heads/master(at){#842052}_without_patch\": {\"absl_hardening_tests\": \"d8491b9a62db4d9a863968facbff671dde9131cd\", \"accessibility_unittests\": \"fafbd74b4eb4f1cc8048770d34317af42164bdd8\", \"angle_unittests\": \"9ade33a5d3e0e9bb855120610fbbe320af10d11e\", \"app_shell_unittests\": \"1130488e3a898ba673cff10a7d256c7fb7cd59a7\", \"aura_unittests\": \"28b78a414133002b692092ce47ff01b1203c313a\", \"base_unittests\": \"41077400fedc01803525a564bc37db016a3a709c\", \"base_util_unittests\": \"24a26c41e25dc1bdb5be92b932cd999ae35dff48\", \"blink_common_unittests\": \"4b8472f7772172b4bffdfa85d36438e34dbda207\", \"blink_fuzzer_unittests\": \"7b450f9697196e8836a55b5b675bc00f9b44c4b0\", \"blink_heap_unittests\": \"17dd0eec5286ff5c16f30d1a03931de648ee0567\", \"blink_platform_unittests\": \"5b0bcbb6df0d473309d30c174a7496ca50a552d7\", \"blink_python_tests\": \"f0af10372f29f859bf50437ed216e720e12fbbe2\", \"blink_unittests\": \"b372b46d82adaf2c4534c940b56104ff9cf31e32\", \"blink_web_tests\": \"b94da5bcac37f7aa06da7c2786095a3729baddcd\", \"boringssl_crypto_tests\": \"e6f62bf319564dd196f8912a83dea8c3f619ad02\", \"boringssl_ssl_tests\": \"cc613be6d9c11280c3cbcb9a7eefaad0cd75679d\", \"browser_tests\": \"a224d5c7c57a1b0db676da78fe40ca0524420af4\", \"capture_unittests\": \"def1538c023e1ee58533160a95d3fef9f3c44449\", \"cast_unittests\": \"50d8fa1196bbaa48c35e066b231036e8f5ece7cd\", \"cc_unittests\": \"bff3ff21b725f5f69c00ebed01ac96ba08054bb9\", \"chrome_app_unittests\": \"8452b1ea349146ed4dba545359560282a8e1ec04\", \"chromedriver_unittests\": \"f684935361093a3e29b194735f63b3123c433ad5\", \"components_browsertests\": \"9e1ad0c9c611bf993a17fff031ef2dc9cb9f0715\", \"components_unittests\": \"79f43a40acd94f788b17bd85cba0291cf5ccaff5\", \"compositor_unittests\": \"91bcbbc74a9b1c41e12a5f2ccc1f0bef3743a47e\", \"content_browsertests\": \"451e40d6d4a95f36b12ca17df4323b66a5abe053\", \"content_shell_crash_test\": \"a7435b1c4956bfe92e52e9862dfd9471ca4db562\", \"content_unittests\": \"0dba7b975a2e975f550ecde4db00697e88d1f69f\", \"crashpad_tests\": \"92af23f77708a24b936468cb6e214275c6ab7572\", \"cronet_tests\": \"2f09fb52dfa0f27ad4bb50cd422492c139eba3f3\", \"cronet_unittests\": \"ee65b47e162d13b5c3b253ba852ef2ad3df2ee4a\", \"crypto_unittests\": \"3f59db776d81f4f187d34e849c2d63ee92de451b\", \"dbus_unittests\": \"12d052c040f9ed593e94568653934214901d051a\", \"device_unittests\": \"152168810103f38d68ce076781f09d89a3735042\", \"display_unittests\": \"998f1e3fc101229c0489d8f4aaac98ed0d923534\", \"events_unittests\": \"c7472b0821107eae3a413b11fa4e251c52e15ecd\", \"extensions_browsertests\": \"39f852f0eb31b3ab7710cd82b0a3d8421d83ae7d\", \"extensions_unittests\": \"5c959a76a64a1df626ac49425d529ffdcb9e8ed4\", \"filesystem_service_unittests\": \"261efecf66721ca6f35f4d188bb49197e3d23aba\", \"flatbuffers_unittests\": \"4bfbc03ee915ceb403762a954283c8c944ac6944\", \"gcm_unit_tests\": \"08dbc82bf64d24a1579340d7acea9f3b4c89d68f\", \"gfx_unittests\": \"6e2f2d79421867715068556ee4336fb1b903195b\", \"gin_unittests\": \"dffd1084eeba1f6bc3f31b86c8ed24561588a734\", \"google_apis_unittests\": \"5c9d55537be924f4445ac8f044fc3ff2e5a81bf2\", \"gpu_unittests\": \"783cac54b2b3474c7dd1d028436df6e8ea69d466\", \"grit_python_unittests\": \"0718a5373aa0ae8758877d63c90aad8024074ace\", \"gwp_asan_unittests\": \"8bd019c122745aa6758eb293eebb6ecff783be1e\", \"headless_browsertests\": \"4012a1db26c305a5b3a6082ac2d8abea421f2803\", \"headless_unittests\": \"fa8cb4a98d439a96397a8c8f2987d5580331865e\", \"interactive_ui_tests\": \"7aff10d6b4f02a42a88ca1ae3d44e08d55a77049\", \"ipc_tests\": \"b997d04cde58683189d85a9d4786d414788ae0f8\", \"jingle_unittests\": \"8dd6a3b993e13886e66f9e9a54618794e209076c\", \"latency_unittests\": \"8413970ac31e9d3075c4a621cae0e354ee947965\", \"libjingle_xmpp_unittests\": \"c0d4dd3ebdd306e8a8e294adacfd35e9e9c6f85a\", \"liburlpattern_unittests\": \"9904d70515a5172ff1838f9447c8dc43931f0f55\", \"media_blink_unittests\": \"367c82c1cfdce88ea62020eb9e603bb428e02a32\", \"media_unittests\": \"488312885179000d79d86ae26b19ebb2c86e2599\", \"message_center_unittests\": \"347e8dbf104b65acf3f538e6dda0652cb13f4967\", \"metrics_python_tests\": \"2f7d868f5213baaa1f57aaed478ed2864b80ca6c\", \"midi_unittests\": \"96ab6cea7f098e48e76b7483a7ad8ac7a6d89704\", \"mojo_core_unittests\": \"0de69aebc7d25de3a46589160e68b0d97290a471\", \"mojo_unittests\": \"3cce4e26cb957dfd2154739cb02000855687e67b\", \"nacl_helper_nonsfi_unittests\": \"3b16bce52ae3fc812da8ca86b058544755b4eb55\", \"nacl_loader_unittests\": \"8e57755f4a6a1c529dee381220e74196995881e7\", \"native_theme_unittests\": \"26c58e14f6b0010e97d84912b703e07ef38c155b\", \"net_unittests\": \"767ea4bc0a696027276b5871f88bde9da7fed0f7\", \"openscreen_unittests\": \"e2762d1120ee1dc4e0b71e95f263418d24b41808\", \"pdf_unittests\": \"4ae819ac2d59ee67d3127297d83b7cf9e7e331ba\", \"perfetto_unittests\": \"3be47a1aabf2946834127b5cef36d5913707c7be\", \"ppapi_unittests\": \"8e285d5be9cc4f5133f47a157cbc4f9f25768ba1\", \"printing_unittests\": \"3e0bbc41ca55c87c8aceb59e9619cf706fb9fd07\", \"remoting_unittests\": \"f96808b331324913e946cece37759b968437ee2f\", \"sandbox_linux_unittests\": \"d6054845ce73a67f3b0532d0d033bcb29297e856\", \"service_manager_unittests\": \"9cfe8b050534fe4d9653be53f67f02824adf3bab\", \"services_unittests\": \"9105c3d4426238dd9ca32ed2ca3abd2bf2a43e7f\", \"shell_dialogs_unittests\": \"46ef557627eb83807c4b1a702e3a164016c86167\", \"skia_unittests\": \"ec07e7711395d004e5942deaf9c15e3cb66d2015\", \"snapshot_unittests\": \"c927905839255a865dd736d1bf0b2a511c2c9baf\", \"sql_unittests\": \"34911c1212ab620195578637a351361958abbbc0\", \"storage_unittests\": \"73b217801f78a850fdea34860ee9ebdc8218365c\", \"sync_integration_tests\": \"7f0e13845987fb81e252870e4fc9fc8da8b22956\", \"telemetry_gpu_unittests\": \"53d09578dd5b6d6e63b6073decfd4522dda27f2f\", \"telemetry_perf_unittests\": \"2092938cb3dd9160452db537e86c07ed386695ea\", \"telemetry_unittests\": \"4231f6b6b6d59af576ff462bc589fccb02ba532a\", \"traffic_annotation_auditor_unittests\": \"970b6430cfe7c48086564ec9737a5a450dbded16\", \"ui_base_unittests\": \"6d74ab34cee42a94ea517f2b12619da23e4ab8c3\", \"ui_touch_selection_unittests\": \"766c900ead5d27898b126b259f4d8fcbbb142fa5\", \"unit_tests\": \"a780ff4a747cf3a811df09b7739840c71b00bfef\", \"url_unittests\": \"6a32e02789f2e24288e3757dddc477412d2a92cb\", \"views_perftests\": \"1c95d0f5d8ea2cd52aa04bf9743f1ea7fe292dab\", \"views_unittests\": \"9974cbfa0ffe59251ea61172ffb86e1aa6503f75\", \"viz_unittests\": \"00efc4d82872f6e565419abcb9f18e90703642a3\", \"vr_common_unittests\": \"f343bd44222b058c76d78003b5be94c6d33b90a4\", \"vr_pixeltests\": \"8ca3ffc381ecb3af0b1b9913cda12f280454b30a\", \"webdriver_wpt_tests\": \"f3751e72fa835c187384026fdeed6e6a2c2b4934\", \"weblayer_browsertests\": \"b050332f44eaa6f3a7468c7ea57a0061ae3d8300\", \"weblayer_unittests\": \"80e8fec0aa9a7cfb02a8e9a50c72558267be5e37\", \"wm_unittests\": \"0c55645f10bc35de645ff3f95c7c8d8971038a24\", \"wtf_unittests\": \"2f8f00f913b80eb203ac385153560beec7848d49\", \"x11_unittests\": \"c510af5cdec5945be5eca9bba52bbe0d7c6eb427\", \"xr_browser_tests\": \"8bcf80cd0cde884dec407d3ea2ea0c9e8dd30a74\", \"zlib_unittests\": \"50956fb8bace723d47a499a08d9fb766fa1598b3\"}}, \"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-128-r3v6\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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": "1610380830144260",
"status": "COMPLETED",
"status_changed_ts": "1610384313546489",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179532",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6d39c7ae321ce077cc13d6e1e068ab2272ad49fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d39c7ae321ce077cc13d6e1e068ab2272ad49fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023817091528752432",
"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/8858387029554401824/+/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:510afee8e51c4010",
"user_agent:luci-scheduler"
],
"updated_ts": "1610384313580582",
"url": "https://ci.chromium.org/b/8858387029554401824",
"utcnow_ts": "1610384314012474"
}
}
[16:58:34.020] Invocation finished in 58m7.951184726s with status SUCCEEDED