[02:44:20.957] New invocation is queued and will start shortly
[02:44:23.483] Starting the invocation (attempt 1)
[02:44:23.524] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:44:23.524] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:44:23.524] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052314624358989408",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"eca48c5233b83ba8c538fec00f8dc25b117cdecd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052314624358989408",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/eca48c5233b83ba8c538fec00f8dc25b117cdecd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eca48c5233b83ba8c538fec00f8dc25b117cdecd",
"gitiles_ref:refs/heads/master"
]
}
[02:44:24.788] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583203463648033",
"id": "8886884560860246240",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eca48c5233b83ba8c538fec00f8dc25b117cdecd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583203464553671",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169263",
"builder:Linux Builder (dbg)",
"buildset:commit/git/eca48c5233b83ba8c538fec00f8dc25b117cdecd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eca48c5233b83ba8c538fec00f8dc25b117cdecd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052314624358989408",
"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/8886884560860246240/+/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": "1583203464553795",
"url": "https://ci.chromium.org/b/8886884560860246240",
"utcnow_ts": "1583203464767008"
}
}
[02:44:24.788] Task URL: https://ci.chromium.org/b/8886884560860246240
[02:44:24.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:2:0) after 1m0s
[02:45:24.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:2:0)
[02:45:24.855] Timer tick, asking Buildbucket for the build status
[02:45:25.102] Build 8886884560860246240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:25.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:3:0) after 1m0s
[02:46:25.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:3:0)
[02:46:25.132] Timer tick, asking Buildbucket for the build status
[02:46:25.449] Build 8886884560860246240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:25.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:4:0) after 1m0s
[02:47:25.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:4:0)
[02:47:25.426] Timer tick, asking Buildbucket for the build status
[02:47:25.550] Build 8886884560860246240: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:25.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:5:0) after 1m0s
[02:48:05.247] Received PubSub notification, asking Buildbucket for the build status
[02:48:05.591] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:25.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:5:0)
[02:48:25.602] Timer tick, asking Buildbucket for the build status
[02:48:26.124] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:26.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:7:0) after 1m0s
[02:49:26.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:7:0)
[02:49:26.149] Timer tick, asking Buildbucket for the build status
[02:49:26.257] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:26.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:8:0) after 1m0s
[02:50:26.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:8:0)
[02:50:26.278] Timer tick, asking Buildbucket for the build status
[02:50:26.426] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:26.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:9:0) after 1m0s
[02:51:26.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:9:0)
[02:51:26.473] Timer tick, asking Buildbucket for the build status
[02:51:26.622] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:26.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:10:0) after 1m0s
[02:52:26.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:10:0)
[02:52:26.612] Timer tick, asking Buildbucket for the build status
[02:52:26.770] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:26.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:11:0) after 1m0s
[02:53:26.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:11:0)
[02:53:26.827] Timer tick, asking Buildbucket for the build status
[02:53:27.200] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:12:0) after 1m0s
[02:54:27.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:12:0)
[02:54:27.324] Timer tick, asking Buildbucket for the build status
[02:54:27.570] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:27.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:13:0) after 1m0s
[02:55:27.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:13:0)
[02:55:27.600] Timer tick, asking Buildbucket for the build status
[02:55:27.769] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:27.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:14:0) after 1m0s
[02:56:27.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:14:0)
[02:56:27.790] Timer tick, asking Buildbucket for the build status
[02:56:27.951] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:27.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:15:0) after 1m0s
[02:57:28.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:15:0)
[02:57:28.019] Timer tick, asking Buildbucket for the build status
[02:57:28.346] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:28.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:16:0) after 1m0s
[02:58:28.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:16:0)
[02:58:28.420] Timer tick, asking Buildbucket for the build status
[02:58:28.977] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:28.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:17:0) after 1m0s
[02:59:29.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:17:0)
[02:59:29.054] Timer tick, asking Buildbucket for the build status
[02:59:29.178] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:29.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:18:0) after 1m0s
[03:00:29.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:18:0)
[03:00:29.295] Timer tick, asking Buildbucket for the build status
[03:00:29.528] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:29.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:19:0) after 1m0s
[03:01:29.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:19:0)
[03:01:29.549] Timer tick, asking Buildbucket for the build status
[03:01:29.756] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:20:0) after 1m0s
[03:02:29.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:20:0)
[03:02:29.782] Timer tick, asking Buildbucket for the build status
[03:02:29.876] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:29.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:21:0) after 1m0s
[03:03:29.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:21:0)
[03:03:29.892] Timer tick, asking Buildbucket for the build status
[03:03:30.403] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:30.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:22:0) after 1m0s
[03:04:30.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:22:0)
[03:04:30.446] Timer tick, asking Buildbucket for the build status
[03:04:30.654] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:30.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:23:0) after 1m0s
[03:05:30.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:23:0)
[03:05:30.706] Timer tick, asking Buildbucket for the build status
[03:05:30.893] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:30.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:24:0) after 1m0s
[03:06:30.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:24:0)
[03:06:30.958] Timer tick, asking Buildbucket for the build status
[03:06:31.090] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:31.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:25:0) after 1m0s
[03:07:31.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:25:0)
[03:07:31.196] Timer tick, asking Buildbucket for the build status
[03:07:31.311] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:31.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:26:0) after 1m0s
[03:08:31.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:26:0)
[03:08:31.373] Timer tick, asking Buildbucket for the build status
[03:08:33.293] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:33.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:27:0) after 1m0s
[03:09:33.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:27:0)
[03:09:33.316] Timer tick, asking Buildbucket for the build status
[03:09:33.617] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:33.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:28:0) after 1m0s
[03:10:33.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:28:0)
[03:10:33.713] Timer tick, asking Buildbucket for the build status
[03:10:34.119] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:34.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:29:0) after 1m0s
[03:11:34.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:29:0)
[03:11:34.153] Timer tick, asking Buildbucket for the build status
[03:11:34.463] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:34.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:30:0) after 1m0s
[03:12:34.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:30:0)
[03:12:34.517] Timer tick, asking Buildbucket for the build status
[03:12:34.678] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:34.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:31:0) after 1m0s
[03:13:34.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:31:0)
[03:13:34.708] Timer tick, asking Buildbucket for the build status
[03:13:34.946] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:34.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:32:0) after 1m0s
[03:14:35.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:32:0)
[03:14:35.048] Timer tick, asking Buildbucket for the build status
[03:14:35.241] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:35.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:33:0) after 1m0s
[03:15:35.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:33:0)
[03:15:35.337] Timer tick, asking Buildbucket for the build status
[03:15:35.536] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:35.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:34:0) after 1m0s
[03:16:35.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:34:0)
[03:16:35.591] Timer tick, asking Buildbucket for the build status
[03:16:35.731] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:35.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:35:0) after 1m0s
[03:17:35.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:35:0)
[03:17:35.759] Timer tick, asking Buildbucket for the build status
[03:17:35.937] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:35.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:36:0) after 1m0s
[03:18:35.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:36:0)
[03:18:35.990] Timer tick, asking Buildbucket for the build status
[03:18:36.132] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:36.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:37:0) after 1m0s
[03:19:36.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:37:0)
[03:19:36.185] Timer tick, asking Buildbucket for the build status
[03:19:36.361] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:36.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:38:0) after 1m0s
[03:20:36.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:38:0)
[03:20:36.379] Timer tick, asking Buildbucket for the build status
[03:20:36.483] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:36.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:39:0) after 1m0s
[03:21:36.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:39:0)
[03:21:36.455] Timer tick, asking Buildbucket for the build status
[03:21:36.829] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:36.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:40:0) after 1m0s
[03:22:36.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:40:0)
[03:22:36.837] Timer tick, asking Buildbucket for the build status
[03:22:37.161] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:37.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:41:0) after 1m0s
[03:23:37.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:41:0)
[03:23:37.184] Timer tick, asking Buildbucket for the build status
[03:23:37.338] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:37.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:42:0) after 1m0s
[03:24:37.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:42:0)
[03:24:37.378] Timer tick, asking Buildbucket for the build status
[03:24:37.553] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:37.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:43:0) after 1m0s
[03:25:37.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:43:0)
[03:25:37.611] Timer tick, asking Buildbucket for the build status
[03:25:37.749] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:37.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:44:0) after 1m0s
[03:26:37.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:44:0)
[03:26:37.762] Timer tick, asking Buildbucket for the build status
[03:26:37.894] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:37.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:45:0) after 1m0s
[03:27:37.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:45:0)
[03:27:37.915] Timer tick, asking Buildbucket for the build status
[03:27:38.176] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:38.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:46:0) after 1m0s
[03:28:38.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:46:0)
[03:28:38.191] Timer tick, asking Buildbucket for the build status
[03:28:39.005] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:39.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:47:0) after 1m0s
[03:29:39.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:47:0)
[03:29:39.038] Timer tick, asking Buildbucket for the build status
[03:29:39.147] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:39.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:48:0) after 1m0s
[03:30:39.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:48:0)
[03:30:39.159] Timer tick, asking Buildbucket for the build status
[03:30:39.316] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:39.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:49:0) after 1m0s
[03:31:39.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:49:0)
[03:31:39.327] Timer tick, asking Buildbucket for the build status
[03:31:39.578] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:39.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:50:0) after 1m0s
[03:32:39.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:50:0)
[03:32:39.600] Timer tick, asking Buildbucket for the build status
[03:32:39.764] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:51:0) after 1m0s
[03:33:39.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:51:0)
[03:33:39.825] Timer tick, asking Buildbucket for the build status
[03:33:39.934] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:39.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:52:0) after 1m0s
[03:34:39.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:52:0)
[03:34:39.958] Timer tick, asking Buildbucket for the build status
[03:34:40.242] Build 8886884560860246240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:40.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052314624358989408:53:0) after 1m0s
[03:35:01.303] Received PubSub notification, asking Buildbucket for the build status
[03:35:01.405] Build 8886884560860246240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:35:01.405] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583206500478302",
"created_by": "project:chromium",
"created_ts": "1583203463648033",
"id": "8886884560860246240",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eca48c5233b83ba8c538fec00f8dc25b117cdecd\"}}",
"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\"}, \"$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-73-b54o\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169263, \"got_angle_revision\": \"35785308a451034d169ef9e2fc0d16691a9494e8\", \"got_dawn_revision\": \"3ded65e8072e0cdccd0d0edebccffde37d4428b0\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"eca48c5233b83ba8c538fec00f8dc25b117cdecd\", \"got_revision_cp\": \"refs/heads/master@{#746203}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"a4347a9460bb7f2b487a3f7db9d91db7908e6a03\", \"got_v8_revision\": \"93969500907ba1ac7fd7a6ebf3de99acacedc4a1\", \"got_v8_revision_cp\": \"refs/heads/8.2.229@{#1}\", \"got_webrtc_revision\": \"f52d3ed084e30860bfecdc2dcbbc9c3919df779f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30662}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"eca48c5233b83ba8c538fec00f8dc25b117cdecd\", \"swarm_hashes_refs/heads/master(at){#746203}_without_patch\": {\"accessibility_unittests\": \"00614020d35f217bf240ea80023abc9afcd3570d\", \"angle_unittests\": \"4d31c95426fc838c550d7affb391d8785c6b41fb\", \"app_shell_unittests\": \"a9ecc9323461470e6da0554512379e5d2905f815\", \"aura_unittests\": \"e900c0fa5fa300015a38835052c62ade21544d47\", \"base_unittests\": \"0dd947fe8597080946614c82aec35a4723370f25\", \"base_util_unittests\": \"92182848f4dc3e04baf001b2a39c24e0e4dcdfe3\", \"blink_common_unittests\": \"17a547979b74f10d897ea66240ce333de166f2d5\", \"blink_fuzzer_unittests\": \"f3d4c7acd87a534e5b4a1e2066bfcad83b1e6414\", \"blink_heap_unittests\": \"2b3b2fbdfa539fd7d38f034a6df67e0b219ee2a4\", \"blink_platform_unittests\": \"a136352b36f5244ee3dd194c8300f9b091cd7cd0\", \"blink_python_tests\": \"11ae2c4799047286a1a0d12b15968da69ed0952e\", \"blink_unittests\": \"6003699f6779eb5d6a4fb14384f7001d492df04b\", \"blink_web_tests\": \"5b2856468149d19414de66db9e86da2846991d43\", \"boringssl_crypto_tests\": \"347e163d6d7875e7b0fb03c20bd67f307a82e599\", \"boringssl_ssl_tests\": \"2a96fcb5473933e81b7d52e58e4f6dec5248f29b\", \"browser_tests\": \"abdc1558698a66e2eb5318354370bb0f8ca3c25d\", \"cacheinvalidation_unittests\": \"5f450377ea68e46b2962efa8a77199728bf77526\", \"capture_unittests\": \"ee198dc72a8cbd538b2252a455db9a00db3c1910\", \"cast_unittests\": \"a1c7130a1292821d1a39947d1a3f15a074d051db\", \"cc_unittests\": \"a80801edfaba4c02b22c83b9c1dbe9a2b530d52c\", \"chrome_app_unittests\": \"c88aae4fd4e2cc2b7786117f2399410098314803\", \"chromedriver_unittests\": \"9fffe347fe0d837ee73281d41adf02e971ee80fd\", \"components_browsertests\": \"754e57bc3cfa51e217c088619e0410575ccafef7\", \"components_unittests\": \"bca0aed388cfc9cc91b99a9b1866280ff51e4ce9\", \"compositor_unittests\": \"2c00558beb00b37813ab3c3b805e05162c09a6c6\", \"content_browsertests\": \"6a6038e95a7b134f132174e35452ccb3af48bcac\", \"content_shell_crash_test\": \"e67a4426e25860da852283b8e371b8aef95d547a\", \"content_unittests\": \"3d1586fdb730cafb79e0c0282668446f5282127f\", \"crashpad_tests\": \"b6da28bba37ca239ca8314734f1e70db2792ffd4\", \"cronet_tests\": \"73615a7153fe5dac78c848e42ec2e1343ddb0747\", \"cronet_unittests\": \"f9a903832295b328a8d9cc3728e269a7cb215254\", \"crypto_unittests\": \"71c537e26d6586cc5d3b0ac9cb6a00ac21fd3d14\", \"dbus_unittests\": \"b49b55bf28ce2722460e5debd0bbf38435ffabfc\", \"device_unittests\": \"450f5a669d197a16ff8bf0b3acbf02f2a523d2c7\", \"display_unittests\": \"01233d96098b7e1045185102cfb1c42f8c509a8a\", \"events_unittests\": \"a2e53efdc63f2effa73007fa86957f10d332237b\", \"extensions_browsertests\": \"48282c061b84fca910d8137b41fc1ce28f4a30e2\", \"extensions_unittests\": \"392d182d5daeed67b4480baf4b2a447b7c60d1b4\", \"filesystem_service_unittests\": \"192d81a221318005fff80043499b3973bebbd670\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"b9f81949e0b76ed8c271e9b1d4c377aee7960696\", \"gfx_unittests\": \"620ecada97c7aab4296c1aa226948665915db650\", \"gin_unittests\": \"62cca508ca0d89bbbc15b9dbf88d1f6432ce1179\", \"google_apis_unittests\": \"fd2aca77a49c570b613f109c980afbed8b5a0085\", \"gpu_unittests\": \"fbf8b7e5a43206b94e43d009c4e96b163dc1c5a5\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"95c9eb2b3e0b26aa5d0b59c34e6cb0841cd43b1e\", \"headless_browsertests\": \"5809756b839e1b3bdb27ccf8fc006f79a9204be3\", \"headless_unittests\": \"b89c899f0ed5b532f95b5a3c2193eb27f00a2bb6\", \"interactive_ui_tests\": \"940e71c0e31466021ba5f3730d1ad5be4612c8d0\", \"ipc_tests\": \"325f89d6b1aae3eedf70f8c18af27e9a33bb4c21\", \"jingle_unittests\": \"2092bbcc1cfff1dd27216d1be1a41566feb5e0c4\", \"latency_unittests\": \"9915bc7b5315b91dea134893a4f93362a0f20fa1\", \"libjingle_xmpp_unittests\": \"71ed6ab31af78f63d65a45511ba93dc8cd608b36\", \"media_blink_unittests\": \"f358f5ddf021c1114da29fd0dddddbb4622e37cc\", \"media_service_unittests\": \"a3bf6d232772bdf3dcded74da961a7fd0edcae15\", \"media_unittests\": \"ecbb2980cf06b08ec24e710cfcfb33638e992d43\", \"message_center_unittests\": \"dd862b2d629d647fc07db0a622fd7d46ea6b88eb\", \"metrics_python_tests\": \"0254f7326e7f9e84e98a7f09153cf0e15d4c4a7b\", \"midi_unittests\": \"4f31321c2c88a8a0e60f749f17f5547e41176777\", \"mojo_core_unittests\": \"ba467814a0ce146d41e6657d6d5e31e97d622893\", \"mojo_unittests\": \"9712a3b6dc25902726d7e728a0f8cb377feaf804\", \"nacl_helper_nonsfi_unittests\": \"2b6bc8ab9e7a91366204cde5acd98dfb753368db\", \"nacl_loader_unittests\": \"962457f956694042e54ab09555e39bbdb67461da\", \"native_theme_unittests\": \"6864efffde2f200050f71acb779a26312f8279cf\", \"net_unittests\": \"fc1adee9bf55dacd3252bd338004ec8657fd8ff3\", \"pdf_unittests\": \"cdfdff3c652db0f340404eb4b927d524ed00e7c7\", \"perfetto_unittests\": \"0d6ff92abbd6117e2b139ae0f7e29f9e99419177\", \"ppapi_unittests\": \"33b28b547df12b15c2f9d0135132160f6f2158a1\", \"printing_unittests\": \"9823b5f49767f023db89a43efab24de574017823\", \"remoting_unittests\": \"fbdcf22554862519043facf961e3051e6f6c26d2\", \"sandbox_linux_unittests\": \"ac2bbad4245b6865e9a24b7492daad69ac3eefc2\", \"service_manager_unittests\": \"8027125600bcb510a76e9fd46f89ee725e87c246\", \"services_unittests\": \"173b212423a43012aba29a9ff994e53ec68f68ff\", \"shell_dialogs_unittests\": \"8bc26f165013f3a3a1e63fc06c45578be3591d6c\", \"skia_unittests\": \"e9dbbceedaf7932276cbe753de255af0465c4561\", \"snapshot_unittests\": \"dc555a1cd9b1aad45f7d120451392197d915668e\", \"sql_unittests\": \"4d6c59a58b4fd8766b42e9c7c8142538353933a2\", \"storage_unittests\": \"b9f3f326607c4fc04ea9654b9eefd69338c26b60\", \"sync_integration_tests\": \"ab61889aa7b28fbff9cd2226ca32d66b5302544a\", \"telemetry_gpu_unittests\": \"c2e0cc355446aebc7177902df5f6921fa8356758\", \"telemetry_perf_unittests\": \"5195036e5798f825f24c12c2ef95284983469900\", \"telemetry_unittests\": \"af0184316204d2b0a0de11cf1b8d9501bfa33a64\", \"traffic_annotation_auditor_unittests\": \"6dba444da2581436ebf3ba09dfd6e119086f414f\", \"ui_base_unittests\": \"c3dc71f6246fa39b636382a59d45b2b994265799\", \"ui_touch_selection_unittests\": \"90e10eb034399e8ab0a7b510b40335b518a73ba9\", \"unit_tests\": \"c819a1da374549210c30d8b31064252fcfd0f63c\", \"url_unittests\": \"103b5c4db87846c579152b899d1e67b51691adbe\", \"views_perftests\": \"1c69d2cf3520373fcbfd0832b3192fcb15bbe381\", \"views_unittests\": \"385a8e04cf999e30f3e781f7f3600e4c433c56ce\", \"viz_unittests\": \"84810025393d3c8d47d7af5a41edc3a6f6ed5970\", \"vr_common_unittests\": \"90385fbc05b22fed8494dad1a85b6f90a42cdf3d\", \"vr_pixeltests\": \"eff273f5ec0575501229b02dbc496bb30bbb6733\", \"webdriver_wpt_tests\": \"c77c9a91856a3a3b74c9e990117290018239b61f\", \"weblayer_browsertests\": \"34168a167f9232f3fd84696c0aca44b623f82347\", \"wm_unittests\": \"17fd4362fd629cc9a261ff8c05b0a3733b8990f2\", \"wtf_unittests\": \"2bc39a8293397b8baaf72f63b4b14a0fc6a3999e\", \"xr_browser_tests\": \"1eb17498771bd399f9486321e9daf14d7b239629\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_beb776337cf5e2ff0f3cb2908a8270f1e35b65aa6652b9e320dd7c6c902817db_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-73-b54o\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4840-d3c86f9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583203684530054",
"status": "COMPLETED",
"status_changed_ts": "1583206500789513",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169263",
"builder:Linux Builder (dbg)",
"buildset:commit/git/eca48c5233b83ba8c538fec00f8dc25b117cdecd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eca48c5233b83ba8c538fec00f8dc25b117cdecd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052314624358989408",
"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/8886884560860246240/+/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:4ab7193e98a94310",
"user_agent:luci-scheduler"
],
"updated_ts": "1583206500798847",
"url": "https://ci.chromium.org/b/8886884560860246240",
"utcnow_ts": "1583206501397387"
}
}
[03:35:01.405] Invocation finished in 50m40.476482621s with status SUCCEEDED