[02:00:03.201] New invocation is queued and will start shortly
[02:00:04.331] Starting the invocation (attempt 1)
[02:00:04.370] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:00:04.370] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:00:04.370] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059836959435872928",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7fe10ea90459bf88c5b6dd3d1624bde6665d3284\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059836959435872928",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/7fe10ea90459bf88c5b6dd3d1624bde6665d3284",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7fe10ea90459bf88c5b6dd3d1624bde6665d3284",
"gitiles_ref:refs/heads/master"
]
}
[02:00:06.268] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576029604956408",
"id": "8894406896912330128",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7fe10ea90459bf88c5b6dd3d1624bde6665d3284\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576029605806577",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165926",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7fe10ea90459bf88c5b6dd3d1624bde6665d3284",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7fe10ea90459bf88c5b6dd3d1624bde6665d3284",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059836959435872928",
"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/8894406896912330128/+/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": "1576029605806712",
"url": "https://ci.chromium.org/b/8894406896912330128",
"utcnow_ts": "1576029606246973"
}
}
[02:00:06.268] Task URL: https://ci.chromium.org/b/8894406896912330128
[02:00:06.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:2:0) after 1m0s
[02:01:06.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:2:0)
[02:01:06.397] Timer tick, asking Buildbucket for the build status
[02:01:06.628] Build 8894406896912330128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:06.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:3:0) after 1m0s
[02:02:06.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:3:0)
[02:02:06.767] Timer tick, asking Buildbucket for the build status
[02:02:07.181] Build 8894406896912330128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:07.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:4:0) after 1m0s
[02:03:07.412] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:4:0)
[02:03:07.412] Timer tick, asking Buildbucket for the build status
[02:03:09.295] Build 8894406896912330128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:09.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:5:0) after 1m0s
[02:04:09.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:5:0)
[02:04:09.349] Timer tick, asking Buildbucket for the build status
[02:04:09.621] Build 8894406896912330128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:09.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:6:0) after 1m0s
[02:05:09.674] Received PubSub notification, asking Buildbucket for the build status
[02:05:10.855] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:11.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:6:0)
[02:05:11.564] Timer tick, asking Buildbucket for the build status
[02:05:12.215] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:12.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:8:0) after 1m0s
[02:06:12.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:8:0)
[02:06:12.337] Timer tick, asking Buildbucket for the build status
[02:06:12.568] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:12.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:9:0) after 1m0s
[02:07:12.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:9:0)
[02:07:12.650] Timer tick, asking Buildbucket for the build status
[02:07:12.973] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:12.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:10:0) after 1m0s
[02:08:13.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:10:0)
[02:08:13.092] Timer tick, asking Buildbucket for the build status
[02:08:13.293] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:13.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:11:0) after 1m0s
[02:09:13.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:11:0)
[02:09:13.422] Timer tick, asking Buildbucket for the build status
[02:09:14.953] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:14.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:12:0) after 1m0s
[02:10:15.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:12:0)
[02:10:15.215] Timer tick, asking Buildbucket for the build status
[02:10:15.446] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:15.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:13:0) after 1m0s
[02:11:15.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:13:0)
[02:11:15.535] Timer tick, asking Buildbucket for the build status
[02:11:15.804] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:15.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:14:0) after 1m0s
[02:12:16.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:14:0)
[02:12:16.017] Timer tick, asking Buildbucket for the build status
[02:12:16.325] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:16.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:15:0) after 1m0s
[02:13:16.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:15:0)
[02:13:16.472] Timer tick, asking Buildbucket for the build status
[02:13:16.608] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:16.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:16:0) after 1m0s
[02:14:16.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:16:0)
[02:14:16.734] Timer tick, asking Buildbucket for the build status
[02:14:16.935] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:16.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:17:0) after 1m0s
[02:15:17.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:17:0)
[02:15:17.212] Timer tick, asking Buildbucket for the build status
[02:15:17.795] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:17.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:18:0) after 1m0s
[02:16:17.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:18:0)
[02:16:17.952] Timer tick, asking Buildbucket for the build status
[02:16:19.409] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:19.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:19:0) after 1m0s
[02:17:19.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:19:0)
[02:17:19.510] Timer tick, asking Buildbucket for the build status
[02:17:19.838] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:19.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:20:0) after 1m0s
[02:18:19.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:20:0)
[02:18:19.977] Timer tick, asking Buildbucket for the build status
[02:18:20.622] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:20.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:21:0) after 1m0s
[02:19:20.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:21:0)
[02:19:20.836] Timer tick, asking Buildbucket for the build status
[02:19:21.174] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:21.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:22:0) after 1m0s
[02:20:21.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:22:0)
[02:20:21.322] Timer tick, asking Buildbucket for the build status
[02:20:21.497] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:21.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:23:0) after 1m0s
[02:21:21.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:23:0)
[02:21:21.590] Timer tick, asking Buildbucket for the build status
[02:21:21.780] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:21.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:24:0) after 1m0s
[02:22:21.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:24:0)
[02:22:21.935] Timer tick, asking Buildbucket for the build status
[02:22:22.110] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:22.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:25:0) after 1m0s
[02:23:22.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:25:0)
[02:23:22.213] Timer tick, asking Buildbucket for the build status
[02:23:22.706] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:22.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:26:0) after 1m0s
[02:24:22.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:26:0)
[02:24:22.782] Timer tick, asking Buildbucket for the build status
[02:24:23.776] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:23.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:27:0) after 1m0s
[02:25:23.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:27:0)
[02:25:23.865] Timer tick, asking Buildbucket for the build status
[02:25:24.052] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:24.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:28:0) after 1m0s
[02:26:24.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:28:0)
[02:26:24.158] Timer tick, asking Buildbucket for the build status
[02:26:24.365] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:24.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:29:0) after 1m0s
[02:27:24.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:29:0)
[02:27:24.402] Timer tick, asking Buildbucket for the build status
[02:27:24.801] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:24.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:30:0) after 1m0s
[02:28:24.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:30:0)
[02:28:24.842] Timer tick, asking Buildbucket for the build status
[02:28:25.425] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:25.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:31:0) after 1m0s
[02:29:25.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:31:0)
[02:29:25.493] Timer tick, asking Buildbucket for the build status
[02:29:26.799] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:26.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:32:0) after 1m0s
[02:30:26.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:32:0)
[02:30:26.824] Timer tick, asking Buildbucket for the build status
[02:30:27.063] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:27.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:33:0) after 1m0s
[02:31:27.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:33:0)
[02:31:27.153] Timer tick, asking Buildbucket for the build status
[02:31:27.613] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:27.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:34:0) after 1m0s
[02:32:27.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:34:0)
[02:32:27.691] Timer tick, asking Buildbucket for the build status
[02:32:30.114] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:30.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:35:0) after 1m0s
[02:33:30.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:35:0)
[02:33:30.219] Timer tick, asking Buildbucket for the build status
[02:33:30.770] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:30.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:36:0) after 1m0s
[02:34:30.811] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:36:0)
[02:34:30.811] Timer tick, asking Buildbucket for the build status
[02:34:31.072] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:31.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:37:0) after 1m0s
[02:35:31.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:37:0)
[02:35:31.347] Timer tick, asking Buildbucket for the build status
[02:35:31.854] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:31.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:38:0) after 1m0s
[02:36:31.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:38:0)
[02:36:31.973] Timer tick, asking Buildbucket for the build status
[02:36:32.436] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:32.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:39:0) after 1m0s
[02:37:32.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:39:0)
[02:37:32.625] Timer tick, asking Buildbucket for the build status
[02:37:32.840] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:32.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:40:0) after 1m0s
[02:38:32.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:40:0)
[02:38:32.884] Timer tick, asking Buildbucket for the build status
[02:38:34.051] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:34.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:41:0) after 1m0s
[02:39:34.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:41:0)
[02:39:34.082] Timer tick, asking Buildbucket for the build status
[02:39:34.845] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:34.845] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:42:0) after 1m0s
[02:40:34.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:42:0)
[02:40:34.915] Timer tick, asking Buildbucket for the build status
[02:40:35.136] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:35.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:43:0) after 1m0s
[02:41:35.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:43:0)
[02:41:35.287] Timer tick, asking Buildbucket for the build status
[02:41:35.525] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:35.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:44:0) after 1m0s
[02:42:35.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:44:0)
[02:42:35.659] Timer tick, asking Buildbucket for the build status
[02:42:35.832] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:45:0) after 1m0s
[02:43:35.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:45:0)
[02:43:35.960] Timer tick, asking Buildbucket for the build status
[02:43:36.514] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:36.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:46:0) after 1m0s
[02:44:36.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:46:0)
[02:44:36.604] Timer tick, asking Buildbucket for the build status
[02:44:37.274] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:37.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:47:0) after 1m0s
[02:45:37.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:47:0)
[02:45:37.308] Timer tick, asking Buildbucket for the build status
[02:45:37.534] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:37.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:48:0) after 1m0s
[02:46:37.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:48:0)
[02:46:37.596] Timer tick, asking Buildbucket for the build status
[02:46:37.878] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:37.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:49:0) after 1m0s
[02:47:37.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:49:0)
[02:47:37.920] Timer tick, asking Buildbucket for the build status
[02:47:38.237] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:38.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:50:0) after 1m0s
[02:48:38.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:50:0)
[02:48:38.274] Timer tick, asking Buildbucket for the build status
[02:48:38.454] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:38.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:51:0) after 1m0s
[02:49:38.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:51:0)
[02:49:38.659] Timer tick, asking Buildbucket for the build status
[02:49:38.851] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:38.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:52:0) after 1m0s
[02:50:39.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:52:0)
[02:50:39.302] Timer tick, asking Buildbucket for the build status
[02:50:40.162] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:40.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:53:0) after 1m0s
[02:51:41.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:53:0)
[02:51:41.180] Timer tick, asking Buildbucket for the build status
[02:51:41.910] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:41.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:54:0) after 1m0s
[02:52:42.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:54:0)
[02:52:42.162] Timer tick, asking Buildbucket for the build status
[02:52:44.156] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:44.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:55:0) after 1m0s
[02:53:44.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:55:0)
[02:53:44.447] Timer tick, asking Buildbucket for the build status
[02:53:44.763] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:44.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:56:0) after 1m0s
[02:54:44.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:56:0)
[02:54:44.886] Timer tick, asking Buildbucket for the build status
[02:54:45.731] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:45.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:57:0) after 1m0s
[02:55:45.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:57:0)
[02:55:45.812] Timer tick, asking Buildbucket for the build status
[02:55:46.570] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:46.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:58:0) after 1m0s
[02:56:46.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:58:0)
[02:56:46.631] Timer tick, asking Buildbucket for the build status
[02:56:46.997] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:46.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:59:0) after 1m0s
[02:57:47.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:59:0)
[02:57:47.092] Timer tick, asking Buildbucket for the build status
[02:57:47.314] Build 8894406896912330128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:47.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059836959435872928:60:0) after 1m0s
[02:58:16.843] Received PubSub notification, asking Buildbucket for the build status
[02:58:17.793] Build 8894406896912330128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:58:17.793] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576033095977080",
"created_by": "project:chromium",
"created_ts": "1576029604956408",
"id": "8894406896912330128",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7fe10ea90459bf88c5b6dd3d1624bde6665d3284\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-east1-d-8-33-mcbk\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165926, \"got_angle_revision\": \"caa6eccde3ee90fcec9254c86060404c29b7d51a\", \"got_dawn_revision\": \"d1db0e94b0df26a300998a1b4d9560efe9ed3abf\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"7fe10ea90459bf88c5b6dd3d1624bde6665d3284\", \"got_revision_cp\": \"refs/heads/master@{#723652}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"353f3314bf40e3c7d0d5c2e65e931f65e73e7126\", \"got_v8_revision\": \"a7b3b5faf0c910eb2421d9386bcce32de672ba97\", \"got_v8_revision_cp\": \"refs/heads/8.1.12@{#1}\", \"got_webrtc_revision\": \"947a380b81ecd3eb40af30f317e3ccef521d5574\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30056}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7fe10ea90459bf88c5b6dd3d1624bde6665d3284\", \"swarm_hashes_refs/heads/master(at){#723652}_without_patch\": {\"accessibility_unittests\": \"a21a1c9c78affc7859e6264b73c91154f98f4d77\", \"angle_unittests\": \"af11b1f624418e286af20b5e3981dccf123f90f6\", \"app_shell_unittests\": \"a23dbd57ed34e1668ae50b21748584a060273d39\", \"aura_unittests\": \"396d2ff4e3d6d04c58fbaeca6d3935e31a8b6a72\", \"base_unittests\": \"9c5107447d5c376e7923c90b97ebb0e39d7064d5\", \"base_util_unittests\": \"6bf9824b65559a5e3c1ee086b084ac86c4cf0960\", \"blink_common_unittests\": \"fe0736c267b26b33c397c17fa8650adfeb16411a\", \"blink_fuzzer_unittests\": \"a0ea435a762fb060c2adc2739674c1c86f214609\", \"blink_heap_unittests\": \"3ace886126a1f69b4a2cd8877c9a7775e236adce\", \"blink_platform_unittests\": \"0b6609dbbb4ba30748b02309b257b23ac38c8fc2\", \"blink_python_tests\": \"0f83f8569f0988be745ece54699c7c4e4a2d021a\", \"blink_unittests\": \"9d440e72e9ef1d1be69e0c596e35a3d36e3af7e7\", \"blink_web_tests\": \"95003704d33f31011e16f475a376c5722e73cca3\", \"boringssl_crypto_tests\": \"2718b71f4a67c8e94a6dd1e8dc2e60599b2e241c\", \"boringssl_ssl_tests\": \"dd3f4445c5fa16ef7e315d0f4bf8317135dabb5d\", \"browser_tests\": \"624f8c9e334a22b9dd38925cebde585b95d0a33a\", \"cacheinvalidation_unittests\": \"0fabada1bd23bf921f872fd17e6471cdd14011cb\", \"capture_unittests\": \"76001ae7c90b059b259f956869bfbf7245c0d8a0\", \"cast_unittests\": \"775876f2748389ba9080b531b209d2f8b1b5a74f\", \"cc_unittests\": \"38a8338c4c48a2546273719deff6a7840fbd74ff\", \"chrome_app_unittests\": \"c54d8f13bfd8210b73292cbf0db5a8b9e63b7009\", \"chromedriver_unittests\": \"3a9bf0916406be7747bc03719a086176f5b2bded\", \"components_browsertests\": \"df15f7e944c49fbb48dcf49156d34f3255937aba\", \"components_unittests\": \"9105f8b5910670bbbd0aad05089d736281eea72d\", \"compositor_unittests\": \"264eaad55fee68a2811b3a831e2a28d5b30c107c\", \"content_browsertests\": \"e895a72eab4e4f9bcda32cffa24302f6c350210e\", \"content_shell_crash_test\": \"697139ba36c0337989eabe955d91f351d099fa03\", \"content_unittests\": \"e57b1a45b584654c62d0c4a65a2a51d0ac1e00a2\", \"crashpad_tests\": \"80af57f6623b768db9a7abd312a95f202dfbf3ef\", \"cronet_tests\": \"d8255e91c40f3c7be6d1db8577708a5567f138db\", \"cronet_unittests\": \"b1377c7d9a182d0493f34c996b1a04dc632505ed\", \"crypto_unittests\": \"4b816e27349ce4fe53ec3b788c33d64b71b495a0\", \"dbus_unittests\": \"a6906aafe34d7158983c773d6c517ad74b401151\", \"device_unittests\": \"2a68bc7798129d48628c74e74e0a119c415bfc02\", \"devtools_lint_check\": \"a32914318dd62ca0f0849f2ccfcc239beee43692\", \"devtools_type_check\": \"f98a0724cb931b8cc755bc5be71b748084101c90\", \"display_unittests\": \"c98399b3d02f13d576275b125675259b27bfc2a0\", \"events_unittests\": \"0c2fffaa6d1c0db1ca439139dda92073d90f1857\", \"extensions_browsertests\": \"8469aa55a4e01996f40af696777638e3f0f04dc9\", \"extensions_unittests\": \"dbbb1277731f3795b1ac3d5dbff3d712845921af\", \"filesystem_service_unittests\": \"eb5c328bfe118a14b8113d929965c9df6c2fb4a6\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"7fe6e76b5ceccd66b77675471b0227e6e002249a\", \"gfx_unittests\": \"8e96d3a3956b2bc032d26933a6200e11d24817f6\", \"gin_unittests\": \"544c5c713b1186ddec3e1992e5ace0b869061f17\", \"google_apis_unittests\": \"12917fcc7b3a8e8171fa5e5d1976889e753fd5b6\", \"gpu_unittests\": \"20a7d2379621796670622d553d61755baae5de1f\", \"grit_python_unittests\": \"e57825f6dc47aecc895f8acb8b5f5fd25b3001dd\", \"gwp_asan_unittests\": \"acb424e8c48e6babdca6d983a39aeeb40c5fdaa8\", \"headless_browsertests\": \"809da3f94b76a2857bf47ee5a4b203c6b6474ca2\", \"headless_unittests\": \"5b6476fef48f26d3ef743f612f7dfda6d7eb707a\", \"interactive_ui_tests\": \"16bd21799ae1542d7ffef63bb60b4f2501121ac5\", \"ipc_tests\": \"36640e2348722ea4b30ae059b3354d7acf0030f8\", \"jingle_unittests\": \"8cce80185d8c7e4d16cd26c682768317177f81d1\", \"latency_unittests\": \"41daf4b97a241f169f81d7d204c6f2c48ff24d36\", \"libjingle_xmpp_unittests\": \"38add48f972479c8d01dddeda9e124ade967b9b2\", \"media_blink_unittests\": \"95ff3e3d5402f48d982d1e944a2231f8bb38dc4b\", \"media_service_unittests\": \"a4d149d8e7087c6ecdbf85ed807e0923258b57a9\", \"media_unittests\": \"454fcd2eccb3339b318f5a9861fc21f12c314a67\", \"message_center_unittests\": \"747a9acf1d6520aaf5073a6488fedc19ef44a474\", \"metrics_python_tests\": \"985d27ba2503d514b548d9ff063aa85653cb567b\", \"midi_unittests\": \"a72878301ca0ebcb7de08f5793d218885a7c40f4\", \"mojo_core_unittests\": \"406bc2a0b6df151d5878664b7a679a3c14a87fee\", \"mojo_unittests\": \"a979a5aa6d306d4c9e7ccccbccc798c85116fc13\", \"nacl_helper_nonsfi_unittests\": \"76b3ef913f787b77177681354f09c56f0665f483\", \"nacl_loader_unittests\": \"e6b1476b9bf3966a7a543da0490f01a265fe4bd6\", \"native_theme_unittests\": \"27795d378452cf451d4abe2628ee566d8fafa707\", \"net_unittests\": \"e625914d12e0cbc65fddc0fbeaff1d55ab8224e2\", \"pdf_unittests\": \"814e5561f469544ab0f2e39e7ecdb3859216efef\", \"perfetto_unittests\": \"a118de110fa55ec6ebcf8bc7326d394219be3f6a\", \"ppapi_unittests\": \"20e56fcca2f35108725d1cca1298336f15277485\", \"printing_unittests\": \"adfda502e3739bfd4199728f717b432023e31b60\", \"remoting_unittests\": \"10782aad0bce814f12b6ad9cc78a2e7cf6200f6c\", \"sandbox_linux_unittests\": \"5d2613b8bde7d5aa7747467beeeba4bd73a0b2df\", \"service_manager_unittests\": \"28fec11f7d23d56e516da7743ca1bd8071ef1db8\", \"services_unittests\": \"6e69eb1caa45da57171602d200a4561355e67114\", \"shell_dialogs_unittests\": \"465c47b4ed03674244fffea9810701651af2a489\", \"skia_unittests\": \"a59fce3456318de0961c379775263ef7f8e9ec2b\", \"snapshot_unittests\": \"fee8b29444d5206bc316281cca72cd07616a6e85\", \"sql_unittests\": \"0a17edc89b965a2221282fe616cdfea48ddd716f\", \"storage_unittests\": \"81463c9dc80184bf21bc191f0324216335b42b98\", \"sync_integration_tests\": \"f5a2a154845007b562983fe9fa806a6a3f6fc952\", \"telemetry_gpu_unittests\": \"c17dd28e7e37917959d42a17a19f0865f3bbb73e\", \"telemetry_perf_unittests\": \"6cb7aa431cd359487d6b0e55fa17e1a76155c14e\", \"telemetry_unittests\": \"397cb405d5452fe194f4b553c448fd3a0e8fac64\", \"traffic_annotation_auditor_unittests\": \"da9559e6c9b2bd31571a824d49636732cd8a5566\", \"ui_base_unittests\": \"a040b5fa22df3d4c743a7ecbd6a0c07339d80c3f\", \"ui_touch_selection_unittests\": \"d3cb170aec5ee39cb3b6e5e76de78789d4cf5234\", \"unit_tests\": \"b6f6a6f940b8d7f89c6d113114bf20be549fa9ea\", \"url_unittests\": \"c8fcf519e150d1c514f7871a05eae97d0996d5ef\", \"views_perftests\": \"c20a6e0add0c3829e48448784a7028b30e4ceefc\", \"views_unittests\": \"cbb6392984698ec85b7918b3212a5c1bc52f1d4a\", \"viz_unittests\": \"04c93171b5e2b332a9126a2a8b99f7b157f33b24\", \"vr_common_unittests\": \"39257b9db40a6b7eb7f7550f14406bd12ef79b26\", \"vr_pixeltests\": \"9aa0aac87369f46465c7bc41064751054d5517c9\", \"webdriver_wpt_tests\": \"369154ccc73da1ffcbde1cc80ac06edd243e7c8a\", \"weblayer_browsertests\": \"5a9823c0adcd0639c47b0bda12f80cd4d0f8b968\", \"wm_unittests\": \"02de6ea23e2aacd012ad46107f1983521fabb3d3\", \"wtf_unittests\": \"27adaf19fe3f9c70986210f5f70a8a095201c4e4\", \"xr_browser_tests\": \"fcda90feb7c896e6fc03c6bc9e666028e3e5aded\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_26ee0c713798d591dc066c3b18aba10c428b81e49e5d430ca5b1f8f50ef6f654_v2\", \"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"builder_4735eb974b804f74efeb4253a3690e62eb4b060f1d311c87e54f3b58924ad1a2_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_7e09b81c8d06479eaec2630704ae544ecbf4fef920ed2a3aec656c848d7a04d5_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-33-mcbk\"], \"image\": [\"chrome-xenial-19120100-f3a09baa543\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4709-f2c88b6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576029908525703",
"status": "COMPLETED",
"status_changed_ts": "1576033096425309",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165926",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7fe10ea90459bf88c5b6dd3d1624bde6665d3284",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7fe10ea90459bf88c5b6dd3d1624bde6665d3284",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059836959435872928",
"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/8894406896912330128/+/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:490b80ef977b2a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576033096429006",
"url": "https://ci.chromium.org/b/8894406896912330128",
"utcnow_ts": "1576033097774487"
}
}
[02:58:17.793] Invocation finished in 58m14.627343074s with status SUCCEEDED