[04:57:38.529] New invocation is queued and will start shortly
[04:57:39.635] Starting the invocation (attempt 1)
[04:57:39.668] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:57:39.668] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:57:39.669] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021593866673581520",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"126d4db03f6c500400fad8d5df151773e60817d2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021593866673581520",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/126d4db03f6c500400fad8d5df151773e60817d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/126d4db03f6c500400fad8d5df151773e60817d2",
"gitiles_ref:refs/heads/master"
]
}
[04:57:40.237] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612501059742898",
"id": "8856163804737900480",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"126d4db03f6c500400fad8d5df151773e60817d2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612501060087561",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180293",
"builder:Linux Builder (dbg)",
"buildset:commit/git/126d4db03f6c500400fad8d5df151773e60817d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/126d4db03f6c500400fad8d5df151773e60817d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021593866673581520",
"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/8856163804737900480/+/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": "1612501060087670",
"url": "https://ci.chromium.org/b/8856163804737900480",
"utcnow_ts": "1612501060189032"
}
}
[04:57:40.237] Task URL: https://ci.chromium.org/b/8856163804737900480
[04:57:40.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:2:0) after 1m0s
[04:57:41.746] Received PubSub notification, asking Buildbucket for the build status
[04:57:42.706] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:40.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:2:0)
[04:58:40.315] Timer tick, asking Buildbucket for the build status
[04:58:40.594] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:40.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:4:0) after 1m0s
[04:59:40.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:4:0)
[04:59:40.689] Timer tick, asking Buildbucket for the build status
[04:59:40.909] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:40.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:5:0) after 1m0s
[05:00:40.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:5:0)
[05:00:40.908] Timer tick, asking Buildbucket for the build status
[05:00:41.005] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:41.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:6:0) after 1m0s
[05:01:41.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:6:0)
[05:01:41.076] Timer tick, asking Buildbucket for the build status
[05:01:41.346] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:7:0) after 1m0s
[05:02:41.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:7:0)
[05:02:41.488] Timer tick, asking Buildbucket for the build status
[05:02:41.588] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:41.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:8:0) after 1m0s
[05:03:41.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:8:0)
[05:03:41.578] Timer tick, asking Buildbucket for the build status
[05:03:41.652] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:41.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:9:0) after 1m0s
[05:04:41.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:9:0)
[05:04:41.686] Timer tick, asking Buildbucket for the build status
[05:04:41.792] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:10:0) after 1m0s
[05:05:41.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:10:0)
[05:05:41.797] Timer tick, asking Buildbucket for the build status
[05:05:41.859] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:41.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:11:0) after 1m0s
[05:06:41.961] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:11:0)
[05:06:41.961] Timer tick, asking Buildbucket for the build status
[05:06:42.316] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:42.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:12:0) after 1m0s
[05:07:42.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:12:0)
[05:07:42.334] Timer tick, asking Buildbucket for the build status
[05:07:42.496] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:42.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:13:0) after 1m0s
[05:08:42.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:13:0)
[05:08:42.516] Timer tick, asking Buildbucket for the build status
[05:08:42.700] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:42.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:14:0) after 1m0s
[05:09:42.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:14:0)
[05:09:42.753] Timer tick, asking Buildbucket for the build status
[05:09:42.818] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:42.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:15:0) after 1m0s
[05:10:42.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:15:0)
[05:10:42.860] Timer tick, asking Buildbucket for the build status
[05:10:42.924] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:42.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:16:0) after 1m0s
[05:11:43.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:16:0)
[05:11:43.094] Timer tick, asking Buildbucket for the build status
[05:11:43.343] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:43.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:17:0) after 1m0s
[05:12:43.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:17:0)
[05:12:43.333] Timer tick, asking Buildbucket for the build status
[05:12:43.552] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:43.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:18:0) after 1m0s
[05:13:43.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:18:0)
[05:13:43.664] Timer tick, asking Buildbucket for the build status
[05:13:43.895] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:43.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:19:0) after 1m0s
[05:14:43.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:19:0)
[05:14:43.927] Timer tick, asking Buildbucket for the build status
[05:14:43.983] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:43.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:20:0) after 1m0s
[05:15:44.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:20:0)
[05:15:44.000] Timer tick, asking Buildbucket for the build status
[05:15:44.122] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:44.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:21:0) after 1m0s
[05:16:44.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:21:0)
[05:16:44.128] Timer tick, asking Buildbucket for the build status
[05:16:44.198] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:44.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:22:0) after 1m0s
[05:17:44.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:22:0)
[05:17:44.217] Timer tick, asking Buildbucket for the build status
[05:17:44.316] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:44.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:23:0) after 1m0s
[05:18:44.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:23:0)
[05:18:44.334] Timer tick, asking Buildbucket for the build status
[05:18:44.399] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:44.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:24:0) after 1m0s
[05:19:44.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:24:0)
[05:19:44.431] Timer tick, asking Buildbucket for the build status
[05:19:44.485] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:44.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:25:0) after 1m0s
[05:20:44.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:25:0)
[05:20:44.644] Timer tick, asking Buildbucket for the build status
[05:20:44.701] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:44.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:26:0) after 1m0s
[05:21:44.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:26:0)
[05:21:44.734] Timer tick, asking Buildbucket for the build status
[05:21:44.791] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:44.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:27:0) after 1m0s
[05:22:44.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:27:0)
[05:22:44.890] Timer tick, asking Buildbucket for the build status
[05:22:45.010] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:45.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:28:0) after 1m0s
[05:23:45.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:28:0)
[05:23:45.047] Timer tick, asking Buildbucket for the build status
[05:23:45.111] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:45.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:29:0) after 1m0s
[05:24:45.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:29:0)
[05:24:45.096] Timer tick, asking Buildbucket for the build status
[05:24:45.311] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:45.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:30:0) after 1m0s
[05:25:45.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:30:0)
[05:25:45.334] Timer tick, asking Buildbucket for the build status
[05:25:45.415] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:45.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:31:0) after 1m0s
[05:26:45.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:31:0)
[05:26:45.431] Timer tick, asking Buildbucket for the build status
[05:26:45.491] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:45.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:32:0) after 1m0s
[05:27:45.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:32:0)
[05:27:45.516] Timer tick, asking Buildbucket for the build status
[05:27:45.644] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:45.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:33:0) after 1m0s
[05:28:45.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:33:0)
[05:28:45.695] Timer tick, asking Buildbucket for the build status
[05:28:45.763] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:45.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:34:0) after 1m0s
[05:29:45.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:34:0)
[05:29:45.787] Timer tick, asking Buildbucket for the build status
[05:29:45.840] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:45.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:35:0) after 1m0s
[05:30:45.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:35:0)
[05:30:45.860] Timer tick, asking Buildbucket for the build status
[05:30:45.917] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:45.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:36:0) after 1m0s
[05:31:46.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:36:0)
[05:31:46.059] Timer tick, asking Buildbucket for the build status
[05:31:46.256] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:46.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:37:0) after 1m0s
[05:32:46.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:37:0)
[05:32:46.298] Timer tick, asking Buildbucket for the build status
[05:32:46.536] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:46.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:38:0) after 1m0s
[05:33:46.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:38:0)
[05:33:46.569] Timer tick, asking Buildbucket for the build status
[05:33:46.799] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:46.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:39:0) after 1m0s
[05:34:46.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:39:0)
[05:34:46.810] Timer tick, asking Buildbucket for the build status
[05:34:46.863] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:46.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:40:0) after 1m0s
[05:35:46.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:40:0)
[05:35:46.870] Timer tick, asking Buildbucket for the build status
[05:35:47.011] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:47.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:41:0) after 1m0s
[05:36:47.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:41:0)
[05:36:47.031] Timer tick, asking Buildbucket for the build status
[05:36:47.240] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:47.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:42:0) after 1m0s
[05:37:47.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:42:0)
[05:37:47.283] Timer tick, asking Buildbucket for the build status
[05:37:47.408] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:47.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:43:0) after 1m0s
[05:38:47.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:43:0)
[05:38:47.428] Timer tick, asking Buildbucket for the build status
[05:38:48.198] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:48.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:44:0) after 1m0s
[05:39:48.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:44:0)
[05:39:48.317] Timer tick, asking Buildbucket for the build status
[05:39:48.461] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:48.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:45:0) after 1m0s
[05:40:48.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:45:0)
[05:40:48.506] Timer tick, asking Buildbucket for the build status
[05:40:48.823] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:48.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:46:0) after 1m0s
[05:41:48.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:46:0)
[05:41:48.909] Timer tick, asking Buildbucket for the build status
[05:41:48.970] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:48.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:47:0) after 1m0s
[05:42:48.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:47:0)
[05:42:48.990] Timer tick, asking Buildbucket for the build status
[05:42:49.498] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:49.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:48:0) after 1m0s
[05:43:49.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:48:0)
[05:43:49.533] Timer tick, asking Buildbucket for the build status
[05:43:49.692] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:49.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:49:0) after 1m0s
[05:44:49.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:49:0)
[05:44:49.722] Timer tick, asking Buildbucket for the build status
[05:44:49.791] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:49.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:50:0) after 1m0s
[05:45:49.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:50:0)
[05:45:49.869] Timer tick, asking Buildbucket for the build status
[05:45:49.947] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:51:0) after 1m0s
[05:46:49.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:51:0)
[05:46:49.985] Timer tick, asking Buildbucket for the build status
[05:46:50.095] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:50.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:52:0) after 1m0s
[05:47:50.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:52:0)
[05:47:50.112] Timer tick, asking Buildbucket for the build status
[05:47:50.636] Build 8856163804737900480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:50.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021593866673581520:53:0) after 1m0s
[05:48:18.373] Received PubSub notification, asking Buildbucket for the build status
[05:48:18.736] Build 8856163804737900480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:48:18.736] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612504097520581",
"created_by": "project:chromium",
"created_ts": "1612501059742898",
"id": "8856163804737900480",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"126d4db03f6c500400fad8d5df151773e60817d2\"}}",
"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\": \"126d4db03f6c500400fad8d5df151773e60817d2\", \"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-wqyx\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180293, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"4846281d3680e1e34ffeebe556ca25c285bc1151\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"126d4db03f6c500400fad8d5df151773e60817d2\", \"got_revision_cp\": \"refs/heads/master@{#850974}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"3d9850164408ec1c4b4ea60c4515b85853853794\", \"got_v8_revision_cp\": \"refs/heads/9.0.134@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"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\": \"126d4db03f6c500400fad8d5df151773e60817d2\", \"swarm_hashes_refs/heads/master(at){#850974}_without_patch\": {\"absl_hardening_tests\": \"7a8af473953065771d5e3991e131ab0dedfc7fbc\", \"accessibility_unittests\": \"88cc246227187736c962b4fbda474aa337784b70\", \"angle_unittests\": \"e038998eff4021db8cd0a2e3e450d1041705c75c\", \"app_shell_unittests\": \"1f61c7c5c40c71b48afa2690e909884c6d1d344f\", \"aura_unittests\": \"e1fb1eaba008698cde2f888ff132232d12727b81\", \"base_unittests\": \"079a28d30f91626490c23a33a1524238c516d951\", \"base_util_unittests\": \"8af41efb51f2934aff8ed4da0addb98f0aaa34ee\", \"blink_common_unittests\": \"96461d381ae9850005161302b627e32fdc9c6e7a\", \"blink_fuzzer_unittests\": \"00281ba8cb90d6970e22d473c1a056212dcf448f\", \"blink_heap_unittests\": \"08d2ac23e721e689b079d4388d3686f29c4c1a30\", \"blink_platform_unittests\": \"784ff4651ef14a02f371128b4d692648f321ac26\", \"blink_python_tests\": \"5829c47dd196139f964cd51a96565260fef783ff\", \"blink_unittests\": \"f6081fcb548bbadf84ade6df062b1efb19fb9daf\", \"blink_web_tests\": \"2883affe22d08cd69c1ba474e4286587aeed8f04\", \"boringssl_crypto_tests\": \"e947cc0c3e2842153f724e47e5b7b8a4880fac17\", \"boringssl_ssl_tests\": \"21f381763709fb4fe49efd07b5feec333ee37404\", \"browser_tests\": \"e01333e94f1da497632562dc448b594c3454f365\", \"capture_unittests\": \"a62b583b1e2bed310aa24dcbdf8f558a10ac2894\", \"cast_unittests\": \"38d0e80eb9831b27e4128b232b1ce8610bc9a05e\", \"cc_unittests\": \"dd600f6cc28d75f7891b22f4ca819efbdee54c81\", \"chrome_app_unittests\": \"9a53109e4f5fa4ac43e1a91ad98e80f38a8b06da\", \"chromedriver_unittests\": \"b16f041753a5d888336cfacab39b136e41ad7154\", \"components_browsertests\": \"9fec06b8af777992d7054d6762979e8cebb561a1\", \"components_unittests\": \"c38ff83054720a67eb601c4d55b878aabb6d8ccf\", \"compositor_unittests\": \"30533e26974163de122203a9f23339c5fbf3e0b5\", \"content_browsertests\": \"f8c7765d5b7f3b2df94d3f9b587723e20c373b33\", \"content_shell_crash_test\": \"3302e033f5091985a79390e2ba7454ebbf2aa64b\", \"content_unittests\": \"e123ea7d538577864ddb18ac8217c64ea849239f\", \"crashpad_tests\": \"6b146b8870ffc3a7ec053ba22c9bbd2c1e0e8fd6\", \"cronet_tests\": \"5215844d4e86b5f1d5c57dd56a6c4da1d89fe59e\", \"cronet_unittests\": \"e5398d1f6b1341943c0925de2d591fba4c86d9c2\", \"crypto_unittests\": \"152cb64c4f4c67fd46e94c73b9adc255b6d68f42\", \"dbus_unittests\": \"bf8bbc8b1360d2566c623172394637456d62c01e\", \"device_unittests\": \"140270d47c39d5a663ee4684dd5a82e5666a1e7f\", \"display_unittests\": \"84bddd001af63733e19e8d80596b6d93dcca434b\", \"events_unittests\": \"ddc321560d259dc1c51f19553bc1c8b7df357e07\", \"extensions_browsertests\": \"cb0109b18e69def749dfbd1bc9eec70f9a38f148\", \"extensions_unittests\": \"f1619a9681573528e9c62f3bd86cecc99a2ced3f\", \"filesystem_service_unittests\": \"099fddebc2aa0d00da318f2c28bd69e71ab6292c\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"03a87b34cc501b0c4d9c208f6825abe30397a4a3\", \"gfx_unittests\": \"c67d75268d75304ded2d7aa6632cfd247de72706\", \"gin_unittests\": \"6e55ea8088f83b3201ee61cae254d5d977f8ea12\", \"google_apis_unittests\": \"1e0ab42e113ce09bd19270ae019f5f33e33dac80\", \"gpu_unittests\": \"8cac861de52f91881705a1f08fbe61a2d04ae235\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"70c402b1214879db4c02ec39ae4f31ee9b2a54e6\", \"headless_browsertests\": \"31ce19c7dfa04e50a9250d5de2e7174e0ea60b4d\", \"headless_unittests\": \"8b98c703bb1227182225070ef9828ba0bc20ea54\", \"interactive_ui_tests\": \"5c8d5ef62ef951edff69e245fe5f7f13889521d9\", \"ipc_tests\": \"bbb4e12450c629ca4a5ff17763cf5526ca8a9726\", \"jingle_unittests\": \"74b2c9cb3110198eda53fe4dc03b53e1b4959898\", \"latency_unittests\": \"eacaa1418aef6416773c3e61117d5273ea75f86c\", \"libjingle_xmpp_unittests\": \"49c80febc4946e0e6bb60082d94adc9a31137ad1\", \"liburlpattern_unittests\": \"1ae75b7d74ef8757deb569a47554ba4bbea624f2\", \"media_blink_unittests\": \"24ec11d0b1bb6626f48ef2de3ae724827673a372\", \"media_unittests\": \"ee1c55c1d5446368d0e315a552e66c4b130b7a81\", \"message_center_unittests\": \"b84d0e42089f1f9a0494337595a44e62bb43001f\", \"metrics_python_tests\": \"8949c38e970d221c95737278d6dbf9dd548a1c5b\", \"midi_unittests\": \"e69b05d96fe894240c0ebbcb5ef0129edb4f870a\", \"mojo_core_unittests\": \"19dd425e071baeb54e85899a8cc9f7a8cecc210f\", \"mojo_unittests\": \"2719febad9b57b7f67bffc4d42277b3f3999f2bf\", \"nacl_helper_nonsfi_unittests\": \"00159c4ce4f7d8376d126b5793dcf595456a10a2\", \"nacl_loader_unittests\": \"a3c9de44c23415e19b677185334291ffada3edf0\", \"native_theme_unittests\": \"4ac2d4ea0abf9a39aef82d4523322744da2355a4\", \"net_unittests\": \"39e3a2d13e9fd0380e8455075354eeca577bade7\", \"openscreen_unittests\": \"9ffd64dd1665b0e07cc5165b58e3bb2703880fea\", \"pdf_unittests\": \"ec8e658b08cd7eae9875872174a10829492f433e\", \"perfetto_unittests\": \"af7a4972b917445c8a743b437697439d7d8ec584\", \"ppapi_unittests\": \"47cb00a097852ae317fa6aee1173aeddbe8d8920\", \"printing_unittests\": \"1b7bef50f1bce322bca5628da05055326a294621\", \"remoting_unittests\": \"78c7f98b34fd373ab0e9dadeb4ab731351337be7\", \"sandbox_linux_unittests\": \"7e804ba2d5375eb4aed7ac35e332c8e2740fa268\", \"service_manager_unittests\": \"87080662cb2fdc6b2a29819097cda2a8d18a3e01\", \"services_unittests\": \"de7813d3a6b8d0ce15563d9817866c39431e56fa\", \"shell_dialogs_unittests\": \"715975b70dd1b3f9932a9d1ae421be9718d6cf69\", \"skia_unittests\": \"1ee9e9bf2808f75d631c40cc2dd0527bac9c0397\", \"snapshot_unittests\": \"a95c3a2df66b0d3c4080786fd95270704442ed46\", \"sql_unittests\": \"c68348a2971031fa52a6a52718816b39bb7f5a84\", \"storage_unittests\": \"75e59ce62bd4fdf21660062ee63dce6af7897a8d\", \"sync_integration_tests\": \"dc6bb8e5d5c35e80156d1a4925555c21265e3c85\", \"telemetry_gpu_unittests\": \"a631d4c1dcc3f6614b82e1ff51669bb2afb0c0c4\", \"telemetry_perf_unittests\": \"649db60ecfb199c02d54a3b9697baff5444043f3\", \"telemetry_unittests\": \"1b02e089eb35e92f49e9002778e3eec7b7087cac\", \"traffic_annotation_auditor_unittests\": \"b7acc3cd507fb7a910882d650d6b97907a333d28\", \"ui_base_unittests\": \"9a653798dde8414c90f7abcb989c06c78df91ca3\", \"ui_touch_selection_unittests\": \"71072cff1a8a3b2b96fcc36ba959d57e3cad2763\", \"unit_tests\": \"cdf7d8726692eee49f7c636b7d119aab6d6dba1f\", \"url_unittests\": \"e6623d2f95ab3b03a28e1c9142cb1fcaa34339a3\", \"views_perftests\": \"f5d54e4d1508c6a33e22ecbb994a785133c6a44c\", \"views_unittests\": \"f3c3af03e8852b6a09633f2e4a32d7e99a6e7034\", \"viz_unittests\": \"3eeb4a9c89b826c2b737611805be3ab28bf16d1f\", \"vr_common_unittests\": \"83d34c5367eac474821e1affd48fdbeb140485eb\", \"vr_pixeltests\": \"422407a67eccc5bd920f668a8ee491ecfe35355e\", \"webdriver_wpt_tests\": \"cf10e1b28d0a5cbf29aee0949f2ceb5c635d4974\", \"weblayer_browsertests\": \"ef49ea3c547df7393b44228eb900a391bd34d611\", \"weblayer_unittests\": \"93d6376d38fa6feb616d627ea4e7c7e1ee1b9ee5\", \"wm_unittests\": \"e426a2260bc57e1e3a19d9ef450e5c7789536ffc\", \"wtf_unittests\": \"cca504e3484bedee3f7f86c05bbfbf98c2748b1b\", \"x11_unittests\": \"f9bcebd5df72ebd799022a5b1557a60280f03ca0\", \"xr_browser_tests\": \"9d984bf92750b92d9fcb92c604300507648b8152\", \"zlib_unittests\": \"3a346cd892688f9d3fb32dcbc1823904dae9db27\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_37a6efb75484d21403d66fa62f2f0e5111772231983ba4ec0093d39fca548be8_v2\", \"builder_d3ee47a27de6e242d9ac174bcd2903a12a57590a5abb70af1d9c4989bd7f5749_v2\", \"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-wqyx\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612501060981560",
"status": "COMPLETED",
"status_changed_ts": "1612504097932566",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180293",
"builder:Linux Builder (dbg)",
"buildset:commit/git/126d4db03f6c500400fad8d5df151773e60817d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/126d4db03f6c500400fad8d5df151773e60817d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021593866673581520",
"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/8856163804737900480/+/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:51895f13ba282410",
"user_agent:luci-scheduler"
],
"updated_ts": "1612504097937430",
"url": "https://ci.chromium.org/b/8856163804737900480",
"utcnow_ts": "1612504098719726"
}
}
[05:48:18.736] Invocation finished in 50m40.223908306s with status SUCCEEDED