[23:43:58.704] New invocation is queued and will start shortly
[23:43:59.798] Starting the invocation (attempt 1)
[23:43:59.906] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:43:59.906] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:43:59.906] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020345243165179088",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"616c4495141d03384693d12bcb8c5198a604b24c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020345243165179088",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/616c4495141d03384693d12bcb8c5198a604b24c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c4495141d03384693d12bcb8c5198a604b24c",
"gitiles_ref:refs/heads/master"
]
}
[23:44:01.010] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613691840016888",
"id": "8854915181121800256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613691840804210",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180726",
"builder:Linux Builder (dbg)",
"buildset:commit/git/616c4495141d03384693d12bcb8c5198a604b24c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c4495141d03384693d12bcb8c5198a604b24c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020345243165179088",
"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/8854915181121800256/+/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": "1613691840805000",
"url": "https://ci.chromium.org/b/8854915181121800256",
"utcnow_ts": "1613691840997277"
}
}
[23:44:01.010] Task URL: https://ci.chromium.org/b/8854915181121800256
[23:44:01.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:2:0) after 1m0s
[23:44:10.281] Received PubSub notification, asking Buildbucket for the build status
[23:44:10.353] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:01.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:2:0)
[23:45:01.127] Timer tick, asking Buildbucket for the build status
[23:45:01.234] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:01.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:4:0) after 1m0s
[23:46:01.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:4:0)
[23:46:01.974] Timer tick, asking Buildbucket for the build status
[23:46:02.337] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:02.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:5:0) after 1m0s
[23:47:02.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:5:0)
[23:47:02.366] Timer tick, asking Buildbucket for the build status
[23:47:02.447] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:02.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:6:0) after 1m0s
[23:48:02.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:6:0)
[23:48:02.465] Timer tick, asking Buildbucket for the build status
[23:48:02.549] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:02.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:7:0) after 1m0s
[23:49:02.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:7:0)
[23:49:02.645] Timer tick, asking Buildbucket for the build status
[23:49:02.715] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:02.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:8:0) after 1m0s
[23:50:02.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:8:0)
[23:50:02.817] Timer tick, asking Buildbucket for the build status
[23:50:02.909] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:02.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:9:0) after 1m0s
[23:51:02.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:9:0)
[23:51:02.977] Timer tick, asking Buildbucket for the build status
[23:51:03.643] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:03.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:10:0) after 1m0s
[23:52:03.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:10:0)
[23:52:03.642] Timer tick, asking Buildbucket for the build status
[23:52:03.988] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:03.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:11:0) after 1m0s
[23:53:04.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:11:0)
[23:53:04.033] Timer tick, asking Buildbucket for the build status
[23:53:04.115] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:04.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:12:0) after 1m0s
[23:54:04.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:12:0)
[23:54:04.110] Timer tick, asking Buildbucket for the build status
[23:54:04.402] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:04.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:13:0) after 1m0s
[23:55:04.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:13:0)
[23:55:04.468] Timer tick, asking Buildbucket for the build status
[23:55:04.567] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:04.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:14:0) after 1m0s
[23:56:04.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:14:0)
[23:56:04.587] Timer tick, asking Buildbucket for the build status
[23:56:04.661] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:04.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:15:0) after 1m0s
[23:57:04.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:15:0)
[23:57:04.746] Timer tick, asking Buildbucket for the build status
[23:57:04.830] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:04.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:16:0) after 1m0s
[23:58:04.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:16:0)
[23:58:04.870] Timer tick, asking Buildbucket for the build status
[23:58:04.954] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:04.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:17:0) after 1m0s
[23:59:04.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:17:0)
[23:59:04.923] Timer tick, asking Buildbucket for the build status
[23:59:05.007] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:05.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:18:0) after 1m0s
[00:00:05.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:18:0)
[00:00:05.122] Timer tick, asking Buildbucket for the build status
[00:00:05.262] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:05.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:19:0) after 1m0s
[00:01:06.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:19:0)
[00:01:06.067] Timer tick, asking Buildbucket for the build status
[00:01:06.160] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:06.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:20:0) after 1m0s
[00:02:06.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:20:0)
[00:02:06.453] Timer tick, asking Buildbucket for the build status
[00:02:06.814] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:06.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:21:0) after 1m0s
[00:03:06.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:21:0)
[00:03:06.907] Timer tick, asking Buildbucket for the build status
[00:03:07.244] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:07.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:22:0) after 1m0s
[00:04:07.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:22:0)
[00:04:07.354] Timer tick, asking Buildbucket for the build status
[00:04:07.496] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:07.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:23:0) after 1m0s
[00:05:07.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:23:0)
[00:05:07.595] Timer tick, asking Buildbucket for the build status
[00:05:08.053] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:08.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:24:0) after 1m0s
[00:06:08.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:24:0)
[00:06:08.113] Timer tick, asking Buildbucket for the build status
[00:06:08.399] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:08.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:25:0) after 1m0s
[00:07:08.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:25:0)
[00:07:08.460] Timer tick, asking Buildbucket for the build status
[00:07:08.549] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:08.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:26:0) after 1m0s
[00:08:08.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:26:0)
[00:08:08.607] Timer tick, asking Buildbucket for the build status
[00:08:08.695] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:08.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:27:0) after 1m0s
[00:09:08.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:27:0)
[00:09:08.823] Timer tick, asking Buildbucket for the build status
[00:09:08.928] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:08.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:28:0) after 1m0s
[00:10:09.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:28:0)
[00:10:09.059] Timer tick, asking Buildbucket for the build status
[00:10:09.325] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:09.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:29:0) after 1m0s
[00:11:09.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:29:0)
[00:11:09.333] Timer tick, asking Buildbucket for the build status
[00:11:09.400] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:09.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:30:0) after 1m0s
[00:12:09.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:30:0)
[00:12:09.445] Timer tick, asking Buildbucket for the build status
[00:12:09.580] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:09.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:31:0) after 1m0s
[00:13:09.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:31:0)
[00:13:09.591] Timer tick, asking Buildbucket for the build status
[00:13:09.679] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:09.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:32:0) after 1m0s
[00:14:09.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:32:0)
[00:14:09.799] Timer tick, asking Buildbucket for the build status
[00:14:10.223] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:10.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:33:0) after 1m0s
[00:15:10.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:33:0)
[00:15:10.670] Timer tick, asking Buildbucket for the build status
[00:15:10.915] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:10.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:34:0) after 1m0s
[00:16:11.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:34:0)
[00:16:11.169] Timer tick, asking Buildbucket for the build status
[00:16:11.401] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:11.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:35:0) after 1m0s
[00:17:11.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:35:0)
[00:17:11.792] Timer tick, asking Buildbucket for the build status
[00:17:11.926] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:11.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:36:0) after 1m0s
[00:18:11.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:36:0)
[00:18:11.937] Timer tick, asking Buildbucket for the build status
[00:18:14.590] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:14.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:37:0) after 1m0s
[00:19:14.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:37:0)
[00:19:14.724] Timer tick, asking Buildbucket for the build status
[00:19:15.193] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:15.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:38:0) after 1m0s
[00:20:15.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:38:0)
[00:20:15.355] Timer tick, asking Buildbucket for the build status
[00:20:15.452] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:15.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:39:0) after 1m0s
[00:21:15.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:39:0)
[00:21:15.483] Timer tick, asking Buildbucket for the build status
[00:21:15.559] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:15.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:40:0) after 1m0s
[00:22:15.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:40:0)
[00:22:15.612] Timer tick, asking Buildbucket for the build status
[00:22:15.959] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:15.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:41:0) after 1m0s
[00:23:16.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:41:0)
[00:23:16.006] Timer tick, asking Buildbucket for the build status
[00:23:16.136] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:16.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:42:0) after 1m0s
[00:24:16.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:42:0)
[00:24:16.224] Timer tick, asking Buildbucket for the build status
[00:24:16.509] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:16.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:43:0) after 1m0s
[00:25:16.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:43:0)
[00:25:16.556] Timer tick, asking Buildbucket for the build status
[00:25:16.668] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:16.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:44:0) after 1m0s
[00:26:16.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:44:0)
[00:26:16.756] Timer tick, asking Buildbucket for the build status
[00:26:16.827] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:16.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:45:0) after 1m0s
[00:27:16.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:45:0)
[00:27:16.885] Timer tick, asking Buildbucket for the build status
[00:27:17.311] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:17.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:46:0) after 1m0s
[00:28:17.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:46:0)
[00:28:17.387] Timer tick, asking Buildbucket for the build status
[00:28:17.731] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:17.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:47:0) after 1m0s
[00:29:17.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:47:0)
[00:29:17.803] Timer tick, asking Buildbucket for the build status
[00:29:17.888] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:17.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:48:0) after 1m0s
[00:30:17.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:48:0)
[00:30:17.918] Timer tick, asking Buildbucket for the build status
[00:30:18.186] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:18.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:49:0) after 1m0s
[00:31:18.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:49:0)
[00:31:18.201] Timer tick, asking Buildbucket for the build status
[00:31:18.356] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:18.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:50:0) after 1m0s
[00:32:18.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:50:0)
[00:32:18.327] Timer tick, asking Buildbucket for the build status
[00:32:18.502] Build 8854915181121800256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:18.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020345243165179088:51:0) after 1m0s
[00:33:17.792] Received PubSub notification, asking Buildbucket for the build status
[00:33:17.878] Build 8854915181121800256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:33:17.878] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613694796448109",
"created_by": "project:chromium",
"created_ts": "1613691840016888",
"id": "8854915181121800256",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\"}}",
"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\": \"616c4495141d03384693d12bcb8c5198a604b24c\", \"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-26-2i8d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180726, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"616c4495141d03384693d12bcb8c5198a604b24c\", \"got_revision_cp\": \"refs/heads/master@{#855514}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"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\": \"616c4495141d03384693d12bcb8c5198a604b24c\", \"swarm_hashes_refs/heads/master(at){#855514}_without_patch\": {\"absl_hardening_tests\": \"1e4ca349b49dad55cb77b093c7f60df6edf8fe80\", \"accessibility_unittests\": \"342456f60f0bbac7b9e049e29b76a581cf6ae149\", \"angle_unittests\": \"3e189e256aeeea069d1464364e8eb4dc4685ee53\", \"app_shell_unittests\": \"350a69466b1e5f9cf8468bba72ff4e9e5ea34974\", \"aura_unittests\": \"b36ed53c25a0d5568842ebe14d60d3b562a22d6a\", \"base_unittests\": \"2cb46c957929b355b489ab24958b75c1e5eb84b5\", \"base_util_unittests\": \"7cd871b423b00cd18fea39d405f5ffac6362b527\", \"blink_common_unittests\": \"4ebbef3c74d528e797101a19b9375d892a27cf81\", \"blink_fuzzer_unittests\": \"091ccdcacf63586a62156cf4b00c3bda32f3a090\", \"blink_heap_unittests\": \"8852afd9276f6c3dedb0da23230cb7c96a782230\", \"blink_platform_unittests\": \"5afce703524f588c890fd0cab798492672eada1c\", \"blink_python_tests\": \"d3e97989c49fcdccf564ab183064b2334dacfcb2\", \"blink_unittests\": \"8c3ec3c45eb5dd1ad97e4816fe6c74321567a993\", \"blink_web_tests\": \"f43e630c51384c42e307fa2be81ef17f036ecff3\", \"boringssl_crypto_tests\": \"2dfa3c656652dd2b0820057e112128f13ee52fab\", \"boringssl_ssl_tests\": \"2a06d2450a4bbc1d3b54d95c737fdfef553ca152\", \"browser_tests\": \"f35e0ae040111da049ce490e6409675c94417781\", \"capture_unittests\": \"69360a4b2bb078ad1465cb1ff826185cc66c41f8\", \"cast_unittests\": \"1e1ec575e13d970c503dbb0f46311aee34f585d9\", \"cc_unittests\": \"cddcd9efa805f2bbf89d3026dfc623684f14e46b\", \"chrome_app_unittests\": \"a2eef185b3762da66a49551a4000a8df89c13412\", \"chromedriver_unittests\": \"f9733fab5f4a80bfbb6472216d4608325bb33080\", \"components_browsertests\": \"77e0c5b4373ba30b4262af156c3d01442707276c\", \"components_unittests\": \"49ddd6ddcf8fa65957e6943d45ce0bdb38e2d4bc\", \"compositor_unittests\": \"a1f6c1d99181adab7cf28bf6ec038b234821e5f3\", \"content_browsertests\": \"e0b35ff80434056a1416a7762085a9d59d3aa53b\", \"content_shell_crash_test\": \"0babf69101350884e910ffee69ccacb024eaee87\", \"content_unittests\": \"db8feeaf5fbaf33f508ba4dade634ae6b3c96c04\", \"crashpad_tests\": \"eef33485f1dae6706ba4fd62c9e3e32c66aa7580\", \"cronet_tests\": \"fb29abb473cb77623cf3110bdc162b369a1304c9\", \"cronet_unittests\": \"ed56a8883c436146815c38a21f61deaf4c18c1bb\", \"crypto_unittests\": \"8f39a5f0a2e173bd6331562f4027ed68470c6068\", \"dbus_unittests\": \"301c75a0032147044b6f852c042163400dbbc31d\", \"device_unittests\": \"88832387d8b90a81b3f4f1c37421fee7c3da206b\", \"display_unittests\": \"444b2985e6e9a742c810ae57d870ffd802e6d426\", \"events_unittests\": \"d928c600763e0f98e8050dd86ba9b9a8916e3bd7\", \"extensions_browsertests\": \"73162bda6738bf0a562ae796a4847580e8dc22a6\", \"extensions_unittests\": \"61dcd834551f8c609301f090811f627f39e2f0e7\", \"filesystem_service_unittests\": \"07b35c0d52bee64c6998933a297e3cb1234229e6\", \"flatbuffers_unittests\": \"cbfb36c88c5c18b5ae8aa257342592a1aa3f844d\", \"gcm_unit_tests\": \"b9588783a11751e48cf26c607e65afc43f1f6bbc\", \"gfx_unittests\": \"c1588f353a4025113d71ae029170705c3030ef99\", \"gin_unittests\": \"b2226cfdd26ad199b3a658536163675a490ec76a\", \"google_apis_unittests\": \"51ce418829f57f43c613d82dedaabbaad850a8f2\", \"gpu_unittests\": \"10a263db750598cdcf4b99d1a75b6e673e14c463\", \"grit_python_unittests\": \"6b6368f24e937f93faad08449a74ab12b3b62c64\", \"gwp_asan_unittests\": \"0769770ff8a07e4337c0acf486c05d79bf087c85\", \"headless_browsertests\": \"3e2002f4b46e319a79eed524c55667578bf6bc46\", \"headless_unittests\": \"26f88c8054053086446b7a7fe058d9517a73a666\", \"interactive_ui_tests\": \"22222f452a9d3591cf3f80be73550515aecb3a91\", \"ipc_tests\": \"6964157f7d1c186d86961dc46c94dd1216ca92bc\", \"jingle_unittests\": \"3ee175d8808540b697b0a230458fa77b57df3099\", \"latency_unittests\": \"8b9c133b647f4d2dee47e57d91667d6742a35c89\", \"libjingle_xmpp_unittests\": \"e87ba54799efc8c3d4bc4c507017978cb9e941d5\", \"liburlpattern_unittests\": \"f26f543dbc8b12665f0915f2b809ce0f608dccba\", \"media_blink_unittests\": \"cf4713f9c4d42c7765afb49b296165174b790df9\", \"media_unittests\": \"2edcefc1adf0e79e9b0b5fb6d1a42e91048cc5a2\", \"message_center_unittests\": \"11d2c0b59669fa4aeb7c94489a0319ea2d03132e\", \"metrics_python_tests\": \"b88318b3ce91c88afbaed4e29b7ba714903ba464\", \"midi_unittests\": \"260a4e217b08f16f1d4fa9997e9830d532780840\", \"mojo_core_unittests\": \"fb54d8a1aa0a88ff6c918d35ffb300f4fa1fd143\", \"mojo_unittests\": \"0ebebe54ddbda33ac38dfb229a57c849bc266c80\", \"nacl_helper_nonsfi_unittests\": \"7d3af5d01a595ae00089cef38475c278dec61076\", \"nacl_loader_unittests\": \"f29540cc331e1e668194012fcdf8e5c1d92ee457\", \"native_theme_unittests\": \"3680900fa4deeef1f68fb9b69e5d4a927aa7ff66\", \"net_unittests\": \"9cd9af63871bec8dbdf50029f8f281ccb4a5bdc9\", \"openscreen_unittests\": \"718ef70b29e33bc3889e36a848722d18b5373c3b\", \"pdf_unittests\": \"de7a51a9e2344be7eda9b264c8646f673db74444\", \"perfetto_unittests\": \"138436bca8ed16be6030e2617d26ccf6ecd68bb0\", \"ppapi_unittests\": \"f9ec61be7f62747963c4efdd9f35682a80bffea9\", \"printing_unittests\": \"d572e00313ebf873cedcc753499d7b8da4dadc03\", \"remoting_unittests\": \"b46a22c9f0957f939255e53e97c74b40726d71a7\", \"sandbox_linux_unittests\": \"467220479f69edce542498752fd18668f4eaf4f9\", \"service_manager_unittests\": \"9f28f00790d8ded325778d0a76cd5fea301e507c\", \"services_unittests\": \"379d3efc708e3dd7a69a3151917e8a6c12e4310a\", \"shell_dialogs_unittests\": \"0a0af6341a086a8e8bea2e32df94524344af8484\", \"skia_unittests\": \"ddb03b05458e92f9834127c102d6ab38bcb5ca4a\", \"snapshot_unittests\": \"9a84872692bb6e3fb2393f1f30f3a06906f7c533\", \"sql_unittests\": \"6580eb45f45db734e5c0886995dad77a077af2f1\", \"storage_unittests\": \"2708a6123dc774e054cce9ef8159434b70699c7b\", \"sync_integration_tests\": \"4fed6e27f5bc78d19adc47ef79a3f2bf8e622e12\", \"telemetry_gpu_unittests\": \"4662ee159e5813017400c8b8049adc6434e1c0bc\", \"telemetry_perf_unittests\": \"7a1cf19ceeecf51258ae1b889a8abffcd69e3d91\", \"telemetry_unittests\": \"034f2f35bd0acd1d6ab09c0ad1f5c45b45717a3d\", \"traffic_annotation_auditor_unittests\": \"f386887ce0ea4aa07069918b52288054e747dbb5\", \"ui_base_unittests\": \"dc19ae8c68d1bbec01981194f4b90c8fff61b043\", \"ui_touch_selection_unittests\": \"a9899af3f139bafe75da82bcdc9757214f7724bc\", \"unit_tests\": \"8a52741e16121e626caaa13090fb383b4c4cfe0f\", \"url_unittests\": \"59f145df26ea07faf185aee831b7c40dc3a66cf4\", \"views_perftests\": \"ea4ce9233ef8dcefea462a3e8c16a7737813c843\", \"views_unittests\": \"d1c3a9cbd69d80832cf6bdda1e57e66a9c060d49\", \"viz_unittests\": \"baaa7d29bce807c9b14199412c179c20a28b7472\", \"vr_common_unittests\": \"cfa79a648ae136e6c3ab9a573f9243033471991a\", \"vr_pixeltests\": \"aaf9739a33a13579c29284c67f9be630056c7dff\", \"webdriver_wpt_tests\": \"62cd3cdc55245ad727ef3ccf7980c8995de28cf6\", \"weblayer_browsertests\": \"b23b469bbb6d6c4c91f138b0cb34fea940672dc4\", \"weblayer_unittests\": \"e5b82b93ffda3f96bd8a197888f10e7535e7fae5\", \"wm_unittests\": \"080e04ef05e9616c86dc5a0d3820c42cec58dd65\", \"wtf_unittests\": \"175407503458f53988e6f6c883a27d9ac20517da\", \"x11_unittests\": \"94d8cae688727a15c1e176ef11a918908f32fedd\", \"xr_browser_tests\": \"29aa562b234836367ac257c23a6a4df807cf9edf\", \"zlib_unittests\": \"5b14c1b1668eb1e5198c12668b8cbb192114bc53\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_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-26-2i8d\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613691844825065",
"status": "COMPLETED",
"status_changed_ts": "1613694797218650",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180726",
"builder:Linux Builder (dbg)",
"buildset:commit/git/616c4495141d03384693d12bcb8c5198a604b24c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c4495141d03384693d12bcb8c5198a604b24c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020345243165179088",
"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/8854915181121800256/+/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:51d058fa75ceb110",
"user_agent:luci-scheduler"
],
"updated_ts": "1613694797247759",
"url": "https://ci.chromium.org/b/8854915181121800256",
"utcnow_ts": "1613694797869947"
}
}
[00:33:17.878] Invocation finished in 49m19.193879283s with status SUCCEEDED