[02:34:45.465] New invocation is queued and will start shortly
[02:34:47.007] Starting the invocation (attempt 1)
[02:34:47.038] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:34:47.038] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:34:47.038] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019700319891451632",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d07e99ebb75b49d8c37e94e97bfc201933ffbf36\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019700319891451632",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d07e99ebb75b49d8c37e94e97bfc201933ffbf36",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07e99ebb75b49d8c37e94e97bfc201933ffbf36",
"gitiles_ref:refs/heads/master"
]
}
[02:34:48.249] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1614306887173913",
"id": "8854270257433598736",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d07e99ebb75b49d8c37e94e97bfc201933ffbf36\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614306887972171",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180940",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d07e99ebb75b49d8c37e94e97bfc201933ffbf36",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07e99ebb75b49d8c37e94e97bfc201933ffbf36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019700319891451632",
"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/8854270257433598736/+/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": "1614306887972343",
"url": "https://ci.chromium.org/b/8854270257433598736",
"utcnow_ts": "1614306888192296"
}
}
[02:34:48.249] Task URL: https://ci.chromium.org/b/8854270257433598736
[02:34:48.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:2:0) after 1m0s
[02:34:51.046] Received PubSub notification, asking Buildbucket for the build status
[02:34:51.194] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:48.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:2:0)
[02:35:48.242] Timer tick, asking Buildbucket for the build status
[02:35:48.436] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:48.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:4:0) after 1m0s
[02:36:48.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:4:0)
[02:36:48.481] Timer tick, asking Buildbucket for the build status
[02:36:48.563] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:48.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:5:0) after 1m0s
[02:37:48.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:5:0)
[02:37:48.609] Timer tick, asking Buildbucket for the build status
[02:37:48.745] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:48.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:6:0) after 1m0s
[02:38:48.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:6:0)
[02:38:48.767] Timer tick, asking Buildbucket for the build status
[02:38:48.839] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:48.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:7:0) after 1m0s
[02:39:48.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:7:0)
[02:39:48.855] Timer tick, asking Buildbucket for the build status
[02:39:48.943] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:48.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:8:0) after 1m0s
[02:40:48.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:8:0)
[02:40:48.960] Timer tick, asking Buildbucket for the build status
[02:40:49.389] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:49.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:9:0) after 1m0s
[02:41:49.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:9:0)
[02:41:49.429] Timer tick, asking Buildbucket for the build status
[02:41:49.586] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:49.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:10:0) after 1m0s
[02:42:49.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:10:0)
[02:42:49.627] Timer tick, asking Buildbucket for the build status
[02:42:49.708] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:49.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:11:0) after 1m0s
[02:43:49.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:11:0)
[02:43:49.723] Timer tick, asking Buildbucket for the build status
[02:43:49.804] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:49.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:12:0) after 1m0s
[02:44:49.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:12:0)
[02:44:49.821] Timer tick, asking Buildbucket for the build status
[02:44:49.929] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:49.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:13:0) after 1m0s
[02:45:50.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:13:0)
[02:45:50.012] Timer tick, asking Buildbucket for the build status
[02:45:50.099] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:50.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:14:0) after 1m0s
[02:46:50.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:14:0)
[02:46:50.116] Timer tick, asking Buildbucket for the build status
[02:46:50.186] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:50.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:15:0) after 1m0s
[02:47:50.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:15:0)
[02:47:50.214] Timer tick, asking Buildbucket for the build status
[02:47:50.278] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:50.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:16:0) after 1m0s
[02:48:50.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:16:0)
[02:48:50.317] Timer tick, asking Buildbucket for the build status
[02:48:50.398] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:50.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:17:0) after 1m0s
[02:49:50.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:17:0)
[02:49:50.417] Timer tick, asking Buildbucket for the build status
[02:49:50.615] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:50.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:18:0) after 1m0s
[02:50:50.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:18:0)
[02:50:50.631] Timer tick, asking Buildbucket for the build status
[02:50:50.740] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:50.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:19:0) after 1m0s
[02:51:50.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:19:0)
[02:51:50.751] Timer tick, asking Buildbucket for the build status
[02:51:51.091] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:51.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:20:0) after 1m0s
[02:52:51.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:20:0)
[02:52:51.112] Timer tick, asking Buildbucket for the build status
[02:52:51.187] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:51.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:21:0) after 1m0s
[02:53:51.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:21:0)
[02:53:51.204] Timer tick, asking Buildbucket for the build status
[02:53:51.387] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:51.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:22:0) after 1m0s
[02:54:52.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:22:0)
[02:54:52.597] Timer tick, asking Buildbucket for the build status
[02:54:52.726] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:52.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:23:0) after 1m0s
[02:55:52.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:23:0)
[02:55:52.907] Timer tick, asking Buildbucket for the build status
[02:55:52.979] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:52.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:24:0) after 1m0s
[02:56:52.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:24:0)
[02:56:52.997] Timer tick, asking Buildbucket for the build status
[02:56:53.109] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:53.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:25:0) after 1m0s
[02:57:53.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:25:0)
[02:57:53.153] Timer tick, asking Buildbucket for the build status
[02:57:53.253] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:53.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:26:0) after 1m0s
[02:58:53.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:26:0)
[02:58:53.269] Timer tick, asking Buildbucket for the build status
[02:58:53.364] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:53.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:27:0) after 1m0s
[02:59:53.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:27:0)
[02:59:53.405] Timer tick, asking Buildbucket for the build status
[02:59:53.522] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:53.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:28:0) after 1m0s
[03:00:53.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:28:0)
[03:00:53.709] Timer tick, asking Buildbucket for the build status
[03:00:54.025] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:54.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:29:0) after 1m0s
[03:01:54.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:29:0)
[03:01:54.311] Timer tick, asking Buildbucket for the build status
[03:01:54.387] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:54.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:30:0) after 1m0s
[03:02:54.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:30:0)
[03:02:54.511] Timer tick, asking Buildbucket for the build status
[03:02:54.613] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:54.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:31:0) after 1m0s
[03:03:54.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:31:0)
[03:03:54.694] Timer tick, asking Buildbucket for the build status
[03:03:54.772] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:54.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:32:0) after 1m0s
[03:04:54.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:32:0)
[03:04:54.928] Timer tick, asking Buildbucket for the build status
[03:04:55.412] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:55.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:33:0) after 1m0s
[03:05:55.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:33:0)
[03:05:55.603] Timer tick, asking Buildbucket for the build status
[03:05:55.816] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:55.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:34:0) after 1m0s
[03:06:55.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:34:0)
[03:06:55.860] Timer tick, asking Buildbucket for the build status
[03:06:56.036] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:56.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:35:0) after 1m0s
[03:07:56.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:35:0)
[03:07:56.109] Timer tick, asking Buildbucket for the build status
[03:07:56.193] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:56.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:36:0) after 1m0s
[03:08:56.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:36:0)
[03:08:56.407] Timer tick, asking Buildbucket for the build status
[03:08:56.500] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:56.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:37:0) after 1m0s
[03:09:56.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:37:0)
[03:09:56.631] Timer tick, asking Buildbucket for the build status
[03:09:56.923] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:56.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:38:0) after 1m0s
[03:10:56.991] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:38:0)
[03:10:56.991] Timer tick, asking Buildbucket for the build status
[03:10:57.069] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:57.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:39:0) after 1m0s
[03:11:57.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:39:0)
[03:11:57.215] Timer tick, asking Buildbucket for the build status
[03:11:57.310] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:57.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:40:0) after 1m0s
[03:12:57.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:40:0)
[03:12:57.396] Timer tick, asking Buildbucket for the build status
[03:12:57.483] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:57.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:41:0) after 1m0s
[03:13:57.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:41:0)
[03:13:57.565] Timer tick, asking Buildbucket for the build status
[03:13:57.777] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:57.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:42:0) after 1m0s
[03:14:57.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:42:0)
[03:14:57.898] Timer tick, asking Buildbucket for the build status
[03:14:58.286] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:58.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:43:0) after 1m0s
[03:15:58.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:43:0)
[03:15:58.331] Timer tick, asking Buildbucket for the build status
[03:15:58.408] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:58.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:44:0) after 1m0s
[03:16:58.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:44:0)
[03:16:58.513] Timer tick, asking Buildbucket for the build status
[03:16:58.598] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:45:0) after 1m0s
[03:17:58.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:45:0)
[03:17:58.700] Timer tick, asking Buildbucket for the build status
[03:17:59.030] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:59.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:46:0) after 1m0s
[03:18:59.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:46:0)
[03:18:59.061] Timer tick, asking Buildbucket for the build status
[03:18:59.181] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:59.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:47:0) after 1m0s
[03:19:59.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:47:0)
[03:19:59.200] Timer tick, asking Buildbucket for the build status
[03:19:59.317] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:59.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:48:0) after 1m0s
[03:20:59.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:48:0)
[03:20:59.357] Timer tick, asking Buildbucket for the build status
[03:20:59.643] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:59.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:49:0) after 1m0s
[03:21:59.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:49:0)
[03:21:59.724] Timer tick, asking Buildbucket for the build status
[03:22:00.151] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:00.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:50:0) after 1m0s
[03:23:00.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:50:0)
[03:23:00.207] Timer tick, asking Buildbucket for the build status
[03:23:00.288] Build 8854270257433598736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019700319891451632:51:0) after 1m0s
[03:23:27.892] Received PubSub notification, asking Buildbucket for the build status
[03:23:28.525] Build 8854270257433598736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:23:28.525] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1614309807351314",
"created_by": "project:chromium",
"created_ts": "1614306887173913",
"id": "8854270257433598736",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d07e99ebb75b49d8c37e94e97bfc201933ffbf36\"}}",
"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\": \"d07e99ebb75b49d8c37e94e97bfc201933ffbf36\", \"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-168-0ng6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180940, \"got_angle_revision\": \"77637f2dd222530c721018185a90e24a51e7a745\", \"got_dawn_revision\": \"545a6970cbe9e986dd25e01f7ecf2f9a1b17c756\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d07e99ebb75b49d8c37e94e97bfc201933ffbf36\", \"got_revision_cp\": \"refs/heads/master@{#857986}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"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\": \"d07e99ebb75b49d8c37e94e97bfc201933ffbf36\", \"swarm_hashes_refs/heads/master(at){#857986}_without_patch\": {\"absl_hardening_tests\": \"64db1c6bdda56d747660973fc46ce2a0bff4a183\", \"accessibility_unittests\": \"319e1c7a3ad9a46dd5bdd50bb99257d36c92ea33\", \"angle_unittests\": \"249bf60cd7e1e7ded9b2f9afc4ab0a47cc7bd929\", \"app_shell_unittests\": \"25ce87b8d7f30e41a8ed70ede0b4d49df4c0f3a6\", \"aura_unittests\": \"088f7c90a1bc30f8a7980558ef914c54d65674a1\", \"base_unittests\": \"4d55847655a9761f6e3522978bae46c81fa02836\", \"base_util_unittests\": \"53b86b66c4b35fef91373c40d0ec88c73298b74b\", \"blink_common_unittests\": \"e8f6f0d87587c9dfcd513ec541d037620151a5c0\", \"blink_fuzzer_unittests\": \"9ba3ab1e4163e60cc68277acb0162649147883f1\", \"blink_heap_unittests\": \"86fa2074397f1f9be0d2afdb9fe286ea68880ce0\", \"blink_platform_unittests\": \"47e71cf209c2fbdee36e59aad9bb847e007952b7\", \"blink_python_tests\": \"a50696de790ece1f7bf429abf45a5a0e7fbcb05b\", \"blink_unittests\": \"f6f121a7208e91d47cc4d90540a4bc89a1113d9b\", \"blink_web_tests\": \"f6c46900dd36b76f3507849ff0f822c4b1bf9b02\", \"boringssl_crypto_tests\": \"d3555008e711d34c7a90c0e7c7d597ba09fab4e8\", \"boringssl_ssl_tests\": \"f09343b0fe22157cf89831f46bc49dcf318b4169\", \"browser_tests\": \"6cd05bd625bb445489f48ff509f2f11198763836\", \"capture_unittests\": \"3338247bbeb10743503a3826ccab2c98a41c949f\", \"cast_unittests\": \"ebd645fd6b8b10f276b14cc29c0c74206b367521\", \"cc_unittests\": \"1389e0eba64da061ff6992b18bb42981fd1b4d5e\", \"chrome_app_unittests\": \"dc3ba1f0b2f6f37b0b19b7a44ae11546e0d38057\", \"chromedriver_unittests\": \"548c0aaa3c2a380e939b1cf52dedb42fbe38ebaa\", \"color_unittests\": \"4830c85feb972a47dbb284324624bcdb33b4f679\", \"components_browsertests\": \"2f68fd56504e3856050431603f9c4aea11ba009d\", \"components_unittests\": \"4f2b2deab0ebcd162f5e7fdefaa6d32e0132becc\", \"compositor_unittests\": \"f78ed6b1dff8ce1a387b5cd985f530ba39ad8565\", \"content_browsertests\": \"0f6c24b92fa5bd59f41035e4993d89bfc7d7a06b\", \"content_shell_crash_test\": \"ffc69b1a0d460640f445f7012fbc878ed25bb294\", \"content_unittests\": \"a8c3a5dab84c301b5d065be84ce08a7532274d9d\", \"crashpad_tests\": \"16d4bb3653de863c9d177e62cd968a622a88a88f\", \"cronet_tests\": \"0f8b2f7e6a7e050d1548ab9ff3b4859aab3fc108\", \"cronet_unittests\": \"d78400484f13e0685f597543cd9b030676d5cf6e\", \"crypto_unittests\": \"3b902f05f03633949816604301a6cb2a4d620312\", \"dbus_unittests\": \"6542eaa03eafe6ef307e817f09339ab67392a2eb\", \"device_unittests\": \"049955b2089bed3904b4de6c443e89e4511483a0\", \"display_unittests\": \"be64e2993862679854441c025068b947ebc3297a\", \"events_unittests\": \"a3cefdea3170e1ab4b5a27096079590417aee656\", \"extensions_browsertests\": \"5021548653ab5100d67ab4178560c9fae4121265\", \"extensions_unittests\": \"9095013ef048865484866f51b2ab28a24f1a962e\", \"filesystem_service_unittests\": \"2ea51402223474f1074853d97c8e061f33fc3066\", \"flatbuffers_unittests\": \"3e3b6c7bf0c1182740cf5cce7088efe0220a77b5\", \"gcm_unit_tests\": \"5e3aa84977142036a7a985a4e18aef445cb5c04b\", \"gfx_unittests\": \"82e293a8314bac0f815e62cc38b67b28a376724d\", \"gin_unittests\": \"1930796544bc3d54626fe2ecb02fbfee077f1371\", \"google_apis_unittests\": \"8ee81166a826482a3b2c5a66a56eaa8deebc90a8\", \"gpu_unittests\": \"c7e7f2b0ef4554a294c9292ee939b91841bc19cb\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"2246c8653fde953b5dc600d11e2ddf2bd0ad0625\", \"headless_browsertests\": \"444cd2fdfde1b10e94383350f8690bcce7003300\", \"headless_unittests\": \"bd318851ba1e80d847e0698722957983faafb260\", \"interactive_ui_tests\": \"1a0a4b14166f0b87427caae70b01ac8c164fd2bc\", \"ipc_tests\": \"981d22e82a504273be90791f569bf732b6708343\", \"jingle_unittests\": \"5b1aefbfe6bbed268ff8f9c88ff06381667f9a8b\", \"latency_unittests\": \"accb94012724c13013ecff3b8e74c97a84c62b3b\", \"libjingle_xmpp_unittests\": \"327ba6c4fd3cd27b27b2e8ea90755e9b15d1f4db\", \"liburlpattern_unittests\": \"ca3f9234f6919bfaafcda576938da02b81f02869\", \"media_blink_unittests\": \"fda1f3548840301c41097a641cca2d2553d71819\", \"media_unittests\": \"d540248de11ce0ed989f66260fa0757b9656995f\", \"message_center_unittests\": \"5c0c94b1532f2e1db07474e268397d3955380696\", \"metrics_python_tests\": \"ec57dd5023293396bd68fbd77d9cd888bb3b6a8a\", \"midi_unittests\": \"6ccfbdc49c7d22e74f7f436d2e7666d26f1c552d\", \"mojo_core_unittests\": \"a2c58514c7ce45b342c9b77271cd990d5fe04721\", \"mojo_unittests\": \"27234ab6ee85bb4841dd7fdbfd19e2b78ee27b04\", \"nacl_helper_nonsfi_unittests\": \"b159ee377c651e686f44956a7f03d8bf28d3c25b\", \"nacl_loader_unittests\": \"1dd9cfd045f7ff2b55b85db42ad52ce9c5dbd002\", \"native_theme_unittests\": \"549bff0de1ec29a70f9eba126125dcf43f970ecd\", \"net_unittests\": \"50742ebf3b7296da70df5a888adee964714d176a\", \"openscreen_unittests\": \"b7256b884331eeb8db69656aea78aea2d65393e1\", \"pdf_unittests\": \"012f7f3ba65d231d571e9ea412d11a3243e6f181\", \"perfetto_unittests\": \"320e710c7b7d2d2deccd2bb4f6ffa772625f857e\", \"ppapi_unittests\": \"73c6afd03ee2eee4c0a7fc9dd8652b3e2ce66129\", \"printing_unittests\": \"6a0765103f8f98aa4859163d05818cca97669370\", \"remoting_unittests\": \"7f3750cc11a0edd35921beea702cd5775ec70c8c\", \"sandbox_linux_unittests\": \"7f253001ac595c98cb03cc5e64584ffc2f7110b9\", \"service_manager_unittests\": \"f7c301c9f94b96ba9a930647aa547b1ed3b264b9\", \"services_unittests\": \"4a9dfc41287e5ed47e8718132090607880b274ce\", \"shell_dialogs_unittests\": \"a16f5c6f3112e3df8f7be0ec29c253274d890ee2\", \"skia_unittests\": \"38eaf32869148a2b4a612727ff1b0fe99e0d5e7f\", \"snapshot_unittests\": \"d90a4b5144bc4c7b129f9c55fe966a531a2d3c76\", \"sql_unittests\": \"e842f7f4bfe68ddeb81a28a38fdb21985bb210c2\", \"storage_unittests\": \"b48290f9d4175ba96072cf9c52180aeab91d7976\", \"sync_integration_tests\": \"08c8ff581f0f0ad94b814e6b3358fb05903b4570\", \"telemetry_gpu_unittests\": \"f0ab84903300c2b11202877369c06bb6a82e4e80\", \"telemetry_perf_unittests\": \"f1f4144b6d4064e64499218858a93e0d79731cb4\", \"telemetry_unittests\": \"df3ce845369d13e9cd60be3132e5199d333760fa\", \"traffic_annotation_auditor_unittests\": \"9600536562ac306376e715fe5583f1aaca9cc458\", \"ui_base_unittests\": \"f1b31b826c17a0782633773986f7a144ed409bd4\", \"ui_touch_selection_unittests\": \"728965d5d315fd835058722f9572264cadc76d05\", \"unit_tests\": \"4b28bdc6c8782ab213421f5775f124b738630343\", \"url_unittests\": \"fb43328861fc3f6055beb49cec99b7b4be9c1763\", \"views_perftests\": \"833b74eb42253147bbf2750d5b39932615cedb2b\", \"views_unittests\": \"5269c6f127f332d09275d2fc5ec529f76c047623\", \"viz_unittests\": \"8a35da870a79f1c0d18a055e1897febb256bf3fd\", \"vr_common_unittests\": \"78886f053a735683b0f7b292aa678f5ec96fa9e8\", \"vr_pixeltests\": \"1798ed199aedf5ba82c537d792c7822021b5fc8a\", \"webdriver_wpt_tests\": \"22b0dca860c2845c909a69f8d959829f9f0e34af\", \"weblayer_browsertests\": \"9c5a6254ae5bcf09d8dc6ce9c147932ad7e93a17\", \"weblayer_unittests\": \"a7457c6f9438fa1e125f80c72c964e6975fa09eb\", \"wm_unittests\": \"fb74d392a1e5203d0a2deb3cd854e6b1b62df9df\", \"wtf_unittests\": \"2f4a5f226cb7804127eca285d0bafd53264a40f8\", \"x11_unittests\": \"e8b83b537e8abe7f2373825c33750a13dbafe4d2\", \"xr_browser_tests\": \"5cc74eae4ea9e74716970910d607420703c01736\", \"zlib_unittests\": \"d7c689276110d95fb718637733f14e2a0140630d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1baf36be136c6e37e5283db20727ce1fca753922b4729c01ac3834cd33897d7d_v2\", \"builder_4a2b13219f689d34aa475139e9738b55334bf25923df6aa4978f2ee96f164d56_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_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-168-0ng6\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614306890437418",
"status": "COMPLETED",
"status_changed_ts": "1614309807661862",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180940",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d07e99ebb75b49d8c37e94e97bfc201933ffbf36",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07e99ebb75b49d8c37e94e97bfc201933ffbf36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019700319891451632",
"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/8854270257433598736/+/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:51f501d389322610",
"user_agent:luci-scheduler"
],
"updated_ts": "1614309807695201",
"url": "https://ci.chromium.org/b/8854270257433598736",
"utcnow_ts": "1614309808516405"
}
}
[03:23:28.525] Invocation finished in 48m43.078526528s with status SUCCEEDED