[14:34:30.669] New invocation is queued and will start shortly
[14:34:31.852] Starting the invocation (attempt 1)
[14:34:31.899] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:34:31.899] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:34:31.899] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022916527709694640",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7b42cd6053da3d3babc87b949dfb60518c022dd2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022916527709694640",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/7b42cd6053da3d3babc87b949dfb60518c022dd2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7b42cd6053da3d3babc87b949dfb60518c022dd2",
"gitiles_ref:refs/heads/master"
]
}
[14:34:33.181] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611239672003357",
"id": "8857486465647960896",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7b42cd6053da3d3babc87b949dfb60518c022dd2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611239672945454",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179859",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7b42cd6053da3d3babc87b949dfb60518c022dd2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7b42cd6053da3d3babc87b949dfb60518c022dd2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022916527709694640",
"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/8857486465647960896/+/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": "1611239672945566",
"url": "https://ci.chromium.org/b/8857486465647960896",
"utcnow_ts": "1611239673164290"
}
}
[14:34:33.181] Task URL: https://ci.chromium.org/b/8857486465647960896
[14:34:33.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:2:0) after 1m0s
[14:34:35.770] Received PubSub notification, asking Buildbucket for the build status
[14:34:35.842] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:35.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:2:0)
[14:35:35.064] Timer tick, asking Buildbucket for the build status
[14:35:35.227] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:35.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:4:0) after 1m0s
[14:36:35.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:4:0)
[14:36:35.278] Timer tick, asking Buildbucket for the build status
[14:36:35.334] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:35.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:5:0) after 1m0s
[14:37:35.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:5:0)
[14:37:35.481] Timer tick, asking Buildbucket for the build status
[14:37:35.574] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:35.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:6:0) after 1m0s
[14:38:35.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:6:0)
[14:38:35.617] Timer tick, asking Buildbucket for the build status
[14:38:35.722] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:35.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:7:0) after 1m0s
[14:39:35.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:7:0)
[14:39:35.903] Timer tick, asking Buildbucket for the build status
[14:39:36.014] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:36.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:8:0) after 1m0s
[14:40:36.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:8:0)
[14:40:36.138] Timer tick, asking Buildbucket for the build status
[14:40:36.264] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:36.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:9:0) after 1m0s
[14:41:36.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:9:0)
[14:41:36.324] Timer tick, asking Buildbucket for the build status
[14:41:36.394] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:36.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:10:0) after 1m0s
[14:42:36.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:10:0)
[14:42:36.452] Timer tick, asking Buildbucket for the build status
[14:42:36.526] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:36.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:11:0) after 1m0s
[14:43:36.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:11:0)
[14:43:36.509] Timer tick, asking Buildbucket for the build status
[14:43:36.592] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:36.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:12:0) after 1m0s
[14:44:36.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:12:0)
[14:44:36.615] Timer tick, asking Buildbucket for the build status
[14:44:36.718] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:36.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:13:0) after 1m0s
[14:45:36.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:13:0)
[14:45:36.711] Timer tick, asking Buildbucket for the build status
[14:45:36.781] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:36.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:14:0) after 1m0s
[14:46:36.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:14:0)
[14:46:36.800] Timer tick, asking Buildbucket for the build status
[14:46:36.860] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:36.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:15:0) after 1m0s
[14:47:36.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:15:0)
[14:47:36.855] Timer tick, asking Buildbucket for the build status
[14:47:36.927] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:16:0) after 1m0s
[14:48:36.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:16:0)
[14:48:36.938] Timer tick, asking Buildbucket for the build status
[14:48:37.008] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:37.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:17:0) after 1m0s
[14:49:37.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:17:0)
[14:49:37.132] Timer tick, asking Buildbucket for the build status
[14:49:37.257] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:37.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:18:0) after 1m0s
[14:50:37.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:18:0)
[14:50:37.314] Timer tick, asking Buildbucket for the build status
[14:50:37.374] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:37.374] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:19:0) after 1m0s
[14:51:37.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:19:0)
[14:51:37.479] Timer tick, asking Buildbucket for the build status
[14:51:37.554] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:37.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:20:0) after 1m0s
[14:52:37.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:20:0)
[14:52:37.640] Timer tick, asking Buildbucket for the build status
[14:52:37.794] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:37.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:21:0) after 1m0s
[14:53:37.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:21:0)
[14:53:37.833] Timer tick, asking Buildbucket for the build status
[14:53:37.925] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:37.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:22:0) after 1m0s
[14:54:37.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:22:0)
[14:54:37.929] Timer tick, asking Buildbucket for the build status
[14:54:38.028] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:38.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:23:0) after 1m0s
[14:55:38.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:23:0)
[14:55:38.059] Timer tick, asking Buildbucket for the build status
[14:55:38.168] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:38.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:24:0) after 1m0s
[14:56:38.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:24:0)
[14:56:38.206] Timer tick, asking Buildbucket for the build status
[14:56:38.405] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:38.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:25:0) after 1m0s
[14:57:38.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:25:0)
[14:57:38.450] Timer tick, asking Buildbucket for the build status
[14:57:38.519] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:38.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:26:0) after 1m0s
[14:58:38.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:26:0)
[14:58:38.566] Timer tick, asking Buildbucket for the build status
[14:58:38.645] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:38.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:27:0) after 1m0s
[14:59:38.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:27:0)
[14:59:38.695] Timer tick, asking Buildbucket for the build status
[14:59:38.816] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:38.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:28:0) after 1m0s
[15:00:38.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:28:0)
[15:00:38.936] Timer tick, asking Buildbucket for the build status
[15:00:39.567] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:39.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:29:0) after 1m0s
[15:01:39.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:29:0)
[15:01:39.606] Timer tick, asking Buildbucket for the build status
[15:01:39.674] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:39.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:30:0) after 1m0s
[15:02:39.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:30:0)
[15:02:39.660] Timer tick, asking Buildbucket for the build status
[15:02:39.710] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:39.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:31:0) after 1m0s
[15:03:39.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:31:0)
[15:03:39.756] Timer tick, asking Buildbucket for the build status
[15:03:39.824] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:32:0) after 1m0s
[15:04:39.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:32:0)
[15:04:39.843] Timer tick, asking Buildbucket for the build status
[15:04:40.203] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:40.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:33:0) after 1m0s
[15:05:40.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:33:0)
[15:05:40.213] Timer tick, asking Buildbucket for the build status
[15:05:40.336] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:40.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:34:0) after 1m0s
[15:06:40.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:34:0)
[15:06:40.364] Timer tick, asking Buildbucket for the build status
[15:06:40.445] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:40.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:35:0) after 1m0s
[15:07:40.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:35:0)
[15:07:40.491] Timer tick, asking Buildbucket for the build status
[15:07:40.849] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:40.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:36:0) after 1m0s
[15:08:40.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:36:0)
[15:08:40.852] Timer tick, asking Buildbucket for the build status
[15:08:40.993] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:40.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:37:0) after 1m0s
[15:09:41.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:37:0)
[15:09:41.043] Timer tick, asking Buildbucket for the build status
[15:09:41.481] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:41.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:38:0) after 1m0s
[15:10:41.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:38:0)
[15:10:41.490] Timer tick, asking Buildbucket for the build status
[15:10:41.605] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:41.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:39:0) after 1m0s
[15:11:41.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:39:0)
[15:11:41.652] Timer tick, asking Buildbucket for the build status
[15:11:41.728] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:41.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:40:0) after 1m0s
[15:12:41.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:40:0)
[15:12:41.786] Timer tick, asking Buildbucket for the build status
[15:12:41.893] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:41.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:41:0) after 1m0s
[15:13:41.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:41:0)
[15:13:41.923] Timer tick, asking Buildbucket for the build status
[15:13:42.034] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:42.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:42:0) after 1m0s
[15:14:42.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:42:0)
[15:14:42.125] Timer tick, asking Buildbucket for the build status
[15:14:42.252] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:42.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:43:0) after 1m0s
[15:15:43.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:43:0)
[15:15:43.068] Timer tick, asking Buildbucket for the build status
[15:15:43.567] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:43.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:44:0) after 1m0s
[15:16:43.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:44:0)
[15:16:43.602] Timer tick, asking Buildbucket for the build status
[15:16:43.683] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:43.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:45:0) after 1m0s
[15:17:43.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:45:0)
[15:17:43.742] Timer tick, asking Buildbucket for the build status
[15:17:43.791] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:43.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:46:0) after 1m0s
[15:18:43.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:46:0)
[15:18:43.875] Timer tick, asking Buildbucket for the build status
[15:18:43.946] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:43.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:47:0) after 1m0s
[15:19:44.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:47:0)
[15:19:44.046] Timer tick, asking Buildbucket for the build status
[15:19:44.169] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:44.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:48:0) after 1m0s
[15:20:44.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:48:0)
[15:20:44.291] Timer tick, asking Buildbucket for the build status
[15:20:44.496] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:44.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:49:0) after 1m0s
[15:21:44.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:49:0)
[15:21:44.599] Timer tick, asking Buildbucket for the build status
[15:21:44.664] Build 8857486465647960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:44.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022916527709694640:50:0) after 1m0s
[15:22:31.871] Received PubSub notification, asking Buildbucket for the build status
[15:22:31.935] Build 8857486465647960896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:22:31.935] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611242550755655",
"created_by": "project:chromium",
"created_ts": "1611239672003357",
"id": "8857486465647960896",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7b42cd6053da3d3babc87b949dfb60518c022dd2\"}}",
"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\": \"7b42cd6053da3d3babc87b949dfb60518c022dd2\", \"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-125-jmu1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 179859, \"got_angle_revision\": \"9f4b159b7aa06961970da55ebd9317746d8492ea\", \"got_dawn_revision\": \"ef869c2d01d5241ba8d16e6863e8595bc1fac9fd\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"7b42cd6053da3d3babc87b949dfb60518c022dd2\", \"got_revision_cp\": \"refs/heads/master@{#845631}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"099b043d6e4380fa1e8167b30fc5be827bbb0762\", \"got_v8_revision_cp\": \"refs/heads/9.0.36@{#1}\", \"got_webrtc_revision\": \"a7e34d33fe70363acdabd41fe14f91469cdc1619\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33050}\", \"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\": \"7b42cd6053da3d3babc87b949dfb60518c022dd2\", \"swarm_hashes_refs/heads/master(at){#845631}_without_patch\": {\"absl_hardening_tests\": \"c01c37141fdbe032abebc2f391b6bd0099fc8e2e\", \"accessibility_unittests\": \"75f6dc98d065358bfb3a2092d7dc51555ec4733b\", \"angle_unittests\": \"c38872a6cf86091201c0db6dc099d8c66a858f60\", \"app_shell_unittests\": \"bc2696e1e35ae7994b6cd858092967f280bf79a7\", \"aura_unittests\": \"1629903b242fb5098cb8869d7eea47e3e42db3cf\", \"base_unittests\": \"c41a2daebef7cb2343bff3daed6b6cfc41901d92\", \"base_util_unittests\": \"8f64e500e580b92c1c9af82e1ad9335548c989f8\", \"blink_common_unittests\": \"4266f1c4de022e8acbfd260a1e7264a4f1a72d0e\", \"blink_fuzzer_unittests\": \"cd8a4bf613c3476c0e2a556d1db07edd7f8c5946\", \"blink_heap_unittests\": \"b5e2febf934fa5f0c0a4a2a900b99444b5e69713\", \"blink_platform_unittests\": \"052f51ca4222f5fe0ade9c39d5c654f647f0ce1c\", \"blink_python_tests\": \"38826152afe3e383102ae02c0316f3ca26c9f6e8\", \"blink_unittests\": \"94de7d312d7b31e9a448ed706ff837fdb121cbb9\", \"blink_web_tests\": \"cc3c82fc6368ed5211d16fb83efe849d0e2ad189\", \"boringssl_crypto_tests\": \"654ba37b125163d69d33afa5529fec3a1625aa6d\", \"boringssl_ssl_tests\": \"ee10d7dae0f87d38fb3e46e054d359c21df1ff99\", \"browser_tests\": \"80e0b457da2e6ea94cc9fa37ba1c9e469094952e\", \"capture_unittests\": \"7ccb987cc55b07df11570bce7bd08353d5af321d\", \"cast_unittests\": \"c23a7b5f57f6325513c6a612f42ffcf3560c9f26\", \"cc_unittests\": \"15b3a653e90228b582b518708bdce984410241e6\", \"chrome_app_unittests\": \"a914b8c48f3c3ec573620d21ed2eaf207a769cb3\", \"chromedriver_unittests\": \"be74bb900be61e8044c9361f67f06b5b28e4dbd4\", \"components_browsertests\": \"584b78261b0107120a6c47960c6d5337702975cc\", \"components_unittests\": \"f78555bc72f021177eacb80cd4a42e7a667ce9bd\", \"compositor_unittests\": \"0f1fabd4bc63c0add953c2ede7c568fd2cb52329\", \"content_browsertests\": \"f61b13cfaca5df062c07ba07f3f2059e62229925\", \"content_shell_crash_test\": \"10526557c466f140fdc86da6a9fc00fd0a3889af\", \"content_unittests\": \"4cd4dd753e8e4190d83798d0bd9b9c7b6bedd0e0\", \"crashpad_tests\": \"0893566ca9b17ca6fa8834373781e210838cc8d5\", \"cronet_tests\": \"a734b358d670028b065946f28f4ada439bc503fb\", \"cronet_unittests\": \"b50192920475aac25d09d08b77ffbe3fee25be4a\", \"crypto_unittests\": \"be7453a786191ddbf14ac37b606d075e4d5cde68\", \"dbus_unittests\": \"6057195a9318d38a397b7b5e0cb6c40da085fdd3\", \"device_unittests\": \"425c74a840300d2aacf2c3cd46ee232c03906add\", \"display_unittests\": \"8bf8c222b0719738fce7645912c97329f7391a35\", \"events_unittests\": \"d0a99444310b2a98226a1db6dcbdbc9c1f422665\", \"extensions_browsertests\": \"942412d54b2740bcc1b25406401ab1b64829f66f\", \"extensions_unittests\": \"76f22ce17e1765b96b82a3fbc36c7c3be6ef22a6\", \"filesystem_service_unittests\": \"10760e2fb3509c0c4afadc8a51c286704106a52f\", \"flatbuffers_unittests\": \"6c3dbe15c318045b3d96cb08fc2d51ff0e14e495\", \"gcm_unit_tests\": \"71b1ecdd57b7007f0c576b383f90294d4723ee5c\", \"gfx_unittests\": \"4db8c7ff024ef7aba23fe8949a4badd095c7538c\", \"gin_unittests\": \"5a591e8eefd738a998798b1e3207e24d0c1e38e8\", \"google_apis_unittests\": \"8504f9001c2ee428e4494e5ca5bc750db30474b5\", \"gpu_unittests\": \"af22876c58b2c4ef23e507e6dbb304843ffb4c65\", \"grit_python_unittests\": \"0b6d4d52edfdb860d49b4e2f566968b0e84ea187\", \"gwp_asan_unittests\": \"1cfb295bee5ff39cea423f75154a352b992069e6\", \"headless_browsertests\": \"1d0f124c720b2f9c76ae097e7d5bc6f77c197c3d\", \"headless_unittests\": \"fa794ce069206000f38d9deed2d691e67110d469\", \"interactive_ui_tests\": \"38d4f6447d6d47ef645a95ff9369df8c2a80f23d\", \"ipc_tests\": \"d55a19ee87b74eee62833fcac2c2ddefb1b82e4e\", \"jingle_unittests\": \"f9cdc05514d356d0942b60509b5c17f9a0c2f402\", \"latency_unittests\": \"0add9a6f6d7d62215f72c166b7254ee704f813eb\", \"libjingle_xmpp_unittests\": \"728667db13492567f2e98ca6ddd5e87870648a8c\", \"liburlpattern_unittests\": \"634c738d5b2593aae07e826798410a100a53313a\", \"media_blink_unittests\": \"958af2231c264f87ed5377aebcb5d3655ce09e69\", \"media_unittests\": \"abec637c89535b91901b87d633c99e18c12bac49\", \"message_center_unittests\": \"7949e41ff36f39d6dca92cfa8dc3c1c41d0871d8\", \"metrics_python_tests\": \"e5109474526ae71a1cb3839c0040850b10549d52\", \"midi_unittests\": \"bebfc81af3f2498eb3af00e0f25d7f2bdff58fdc\", \"mojo_core_unittests\": \"e86a515e8f9042847bff4d6b441be40d7648da97\", \"mojo_unittests\": \"a4ebfc7c28332734af1cfe96703279c4aa4980cb\", \"nacl_helper_nonsfi_unittests\": \"345a2717ad17e01dd450230ea30e9f4ea132c605\", \"nacl_loader_unittests\": \"b54ee7a293595cba11053175a571b28d9e2d60e2\", \"native_theme_unittests\": \"6e26deaa0b3ca87ef31b351b0613bc2e610b10c3\", \"net_unittests\": \"ebc7e0f806e92e320f158aaf12860851d220cdce\", \"openscreen_unittests\": \"ffbc97856b6770ceaf8a2290fed7f6ef83505279\", \"pdf_unittests\": \"4d155ccd67f3ec8e7f2a12a10e659a29edfe6cce\", \"perfetto_unittests\": \"27c61ea7530fbe5e75ac0ddd88c8cfded00cc046\", \"ppapi_unittests\": \"cdf55e72c9c1094887cfb4d7bf9613c9f75d486a\", \"printing_unittests\": \"3e020da1ef944fba1454ae3a6ab36c59ce600443\", \"remoting_unittests\": \"a66293f25622e9381b075b81d7b1b030304caab1\", \"sandbox_linux_unittests\": \"c34b21d5d3d2164316d86edd46c0d04b3b860c63\", \"service_manager_unittests\": \"0c64b479bb79329087c7c07c0df59695c8b48d37\", \"services_unittests\": \"1f1cb6d9bfead69afd5e2dbfa405a275ff8d27bc\", \"shell_dialogs_unittests\": \"2f3e895664e1052828a5aa8918d3b494e92cbbe7\", \"skia_unittests\": \"d5cc4cba18740e301bf656cbb2c8fac26d5dd8b1\", \"snapshot_unittests\": \"5b7da06098241c0d50454757183fe47cf48dfd8c\", \"sql_unittests\": \"acfd7aea76e47ea6472e9b6aca57dc0d27893fb5\", \"storage_unittests\": \"3593200bc57e6888599bff69db365e3d8be743ba\", \"sync_integration_tests\": \"2d32aa2c16bc8da62ce525407c4d5d242bb3d6c0\", \"telemetry_gpu_unittests\": \"628a09f067236623d53b79c0d4b972ca52c27b5b\", \"telemetry_perf_unittests\": \"6c3f6fda6f6f6db8267f53e5a717d49da6741627\", \"telemetry_unittests\": \"f5290e4c9cb76fdf18324452ca47373202a3a172\", \"traffic_annotation_auditor_unittests\": \"b10a9674033d48a238890c5fe69e488c1c0bc0ee\", \"ui_base_unittests\": \"a00c6f090fee11f1541cfd67866cf923bbf6c294\", \"ui_touch_selection_unittests\": \"25c5ae04d53fcbdad645bbec4af5cf384d08a5ef\", \"unit_tests\": \"556f4f667f71d8f2212a45c04dfe42a391cfc6e4\", \"url_unittests\": \"dc08f6faf8284a03d21d167cb3ab03179f5a5a01\", \"views_perftests\": \"417741b6ca12dde9e2fa2f1f81a792bde8332477\", \"views_unittests\": \"83b432d796bc844cf644d98ed4fbe19cebe302fb\", \"viz_unittests\": \"3088e8e378dcafc21629e8f8808bcc131b935629\", \"vr_common_unittests\": \"321d901f73b6bdf74f7a0edc5a1a1bc5a1e6408f\", \"vr_pixeltests\": \"6378fda2554a224ab9c34992d5b3d7064983db05\", \"webdriver_wpt_tests\": \"5166804e62df4f88de4cd8fcc857685f35b90d27\", \"weblayer_browsertests\": \"37cee9fbe901d36e261c7cfe8d0cf7bf7f2a528f\", \"weblayer_unittests\": \"3c934605057f82b0287c252048b872c3d4f28b24\", \"wm_unittests\": \"21e6ba4a9399d497237b3e69411a8dbceedb3d46\", \"wtf_unittests\": \"37f81790823dc288bfcbdba82c6f48939b171ba7\", \"x11_unittests\": \"2e20c67fe13a9b6c523d353c51bfc04c294d32ae\", \"xr_browser_tests\": \"f763689a48eb7ba46f89ae5b58702df13a14876c\", \"zlib_unittests\": \"7ead85b63570f84882e7c0a646e4c8c876fdaddf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_cc8a16e85eefa617bab544f2f33977139159d8b8c3b7333fd512c64ffd131f2c_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-125-jmu1\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611239674143993",
"status": "COMPLETED",
"status_changed_ts": "1611242551151245",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/179859",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7b42cd6053da3d3babc87b949dfb60518c022dd2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7b42cd6053da3d3babc87b949dfb60518c022dd2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022916527709694640",
"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/8857486465647960896/+/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:513e2fd6c30fe310",
"user_agent:luci-scheduler"
],
"updated_ts": "1611242551186197",
"url": "https://ci.chromium.org/b/8857486465647960896",
"utcnow_ts": "1611242551926816"
}
}
[15:22:31.935] Invocation finished in 48m1.281717894s with status SUCCEEDED