[13:21:31.474] New invocation is queued and will start shortly
[13:21:32.545] Starting the invocation (attempt 1)
[13:21:32.586] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:21:32.586] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:21:32.586] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053905282139121920",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d75c6640c4c96925b9b3c3030c47798661f662fd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053905282139121920",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d75c6640c4c96925b9b3c3030c47798661f662fd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d75c6640c4c96925b9b3c3030c47798661f662fd",
"gitiles_ref:refs/heads/master"
]
}
[13:21:34.125] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581686492785056",
"id": "8888475220099617328",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d75c6640c4c96925b9b3c3030c47798661f662fd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581686493730906",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168597",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d75c6640c4c96925b9b3c3030c47798661f662fd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d75c6640c4c96925b9b3c3030c47798661f662fd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053905282139121920",
"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/8888475220099617328/+/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": "1581686493731273",
"url": "https://ci.chromium.org/b/8888475220099617328",
"utcnow_ts": "1581686494106643"
}
}
[13:21:34.125] Task URL: https://ci.chromium.org/b/8888475220099617328
[13:21:34.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:2:0) after 1m0s
[13:22:34.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:2:0)
[13:22:34.191] Timer tick, asking Buildbucket for the build status
[13:22:34.387] Build 8888475220099617328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:22:34.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:3:0) after 1m0s
[13:23:34.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:3:0)
[13:23:34.437] Timer tick, asking Buildbucket for the build status
[13:23:34.565] Build 8888475220099617328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:23:34.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:4:0) after 1m0s
[13:24:34.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:4:0)
[13:24:34.586] Timer tick, asking Buildbucket for the build status
[13:24:34.988] Build 8888475220099617328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:24:34.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:5:0) after 1m0s
[13:25:35.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:5:0)
[13:25:35.107] Timer tick, asking Buildbucket for the build status
[13:25:35.375] Build 8888475220099617328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:25:35.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:6:0) after 1m0s
[13:26:35.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:6:0)
[13:26:35.447] Timer tick, asking Buildbucket for the build status
[13:26:35.756] Build 8888475220099617328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:26:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:7:0) after 1m0s
[13:26:36.712] Received PubSub notification, asking Buildbucket for the build status
[13:26:36.860] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:35.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:7:0)
[13:27:35.780] Timer tick, asking Buildbucket for the build status
[13:27:36.052] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:36.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:9:0) after 1m0s
[13:28:36.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:9:0)
[13:28:36.080] Timer tick, asking Buildbucket for the build status
[13:28:36.169] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:36.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:10:0) after 1m0s
[13:29:36.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:10:0)
[13:29:36.208] Timer tick, asking Buildbucket for the build status
[13:29:36.333] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:11:0) after 1m0s
[13:30:36.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:11:0)
[13:30:36.386] Timer tick, asking Buildbucket for the build status
[13:30:37.614] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:37.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:12:0) after 1m0s
[13:31:37.662] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:12:0)
[13:31:37.662] Timer tick, asking Buildbucket for the build status
[13:31:37.721] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:37.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:13:0) after 1m0s
[13:32:37.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:13:0)
[13:32:37.773] Timer tick, asking Buildbucket for the build status
[13:32:37.898] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:37.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:14:0) after 1m0s
[13:33:37.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:14:0)
[13:33:37.927] Timer tick, asking Buildbucket for the build status
[13:33:38.156] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:38.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:15:0) after 1m0s
[13:34:38.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:15:0)
[13:34:38.198] Timer tick, asking Buildbucket for the build status
[13:34:38.375] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:38.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:16:0) after 1m0s
[13:35:38.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:16:0)
[13:35:38.463] Timer tick, asking Buildbucket for the build status
[13:35:38.583] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:38.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:17:0) after 1m0s
[13:36:38.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:17:0)
[13:36:38.701] Timer tick, asking Buildbucket for the build status
[13:36:38.766] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:38.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:18:0) after 1m0s
[13:37:38.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:18:0)
[13:37:38.825] Timer tick, asking Buildbucket for the build status
[13:37:38.893] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:38.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:19:0) after 1m0s
[13:38:38.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:19:0)
[13:38:38.956] Timer tick, asking Buildbucket for the build status
[13:38:39.042] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:39.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:20:0) after 1m0s
[13:39:39.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:20:0)
[13:39:39.086] Timer tick, asking Buildbucket for the build status
[13:39:39.341] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:39.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:21:0) after 1m0s
[13:40:39.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:21:0)
[13:40:39.397] Timer tick, asking Buildbucket for the build status
[13:40:39.651] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:22:0) after 1m0s
[13:41:39.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:22:0)
[13:41:39.680] Timer tick, asking Buildbucket for the build status
[13:41:39.792] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:39.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:23:0) after 1m0s
[13:42:39.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:23:0)
[13:42:39.855] Timer tick, asking Buildbucket for the build status
[13:42:40.053] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:40.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:24:0) after 1m0s
[13:43:40.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:24:0)
[13:43:40.183] Timer tick, asking Buildbucket for the build status
[13:43:40.273] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:40.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:25:0) after 1m0s
[13:44:40.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:25:0)
[13:44:40.351] Timer tick, asking Buildbucket for the build status
[13:44:40.724] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:40.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:26:0) after 1m0s
[13:45:40.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:26:0)
[13:45:40.832] Timer tick, asking Buildbucket for the build status
[13:45:41.006] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:41.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:27:0) after 1m0s
[13:46:41.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:27:0)
[13:46:41.057] Timer tick, asking Buildbucket for the build status
[13:46:41.171] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:41.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:28:0) after 1m0s
[13:47:41.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:28:0)
[13:47:41.223] Timer tick, asking Buildbucket for the build status
[13:47:41.463] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:41.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:29:0) after 1m0s
[13:48:41.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:29:0)
[13:48:41.450] Timer tick, asking Buildbucket for the build status
[13:48:41.642] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:41.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:30:0) after 1m0s
[13:49:41.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:30:0)
[13:49:41.728] Timer tick, asking Buildbucket for the build status
[13:49:42.237] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:42.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:31:0) after 1m0s
[13:50:42.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:31:0)
[13:50:42.292] Timer tick, asking Buildbucket for the build status
[13:50:42.397] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:42.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:32:0) after 1m0s
[13:51:42.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:32:0)
[13:51:42.440] Timer tick, asking Buildbucket for the build status
[13:51:42.527] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:42.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:33:0) after 1m0s
[13:52:42.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:33:0)
[13:52:42.545] Timer tick, asking Buildbucket for the build status
[13:52:42.649] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:42.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:34:0) after 1m0s
[13:53:42.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:34:0)
[13:53:42.660] Timer tick, asking Buildbucket for the build status
[13:53:42.821] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:42.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:35:0) after 1m0s
[13:54:42.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:35:0)
[13:54:42.873] Timer tick, asking Buildbucket for the build status
[13:54:43.085] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:43.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:36:0) after 1m0s
[13:55:43.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:36:0)
[13:55:43.140] Timer tick, asking Buildbucket for the build status
[13:55:43.261] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:43.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:37:0) after 1m0s
[13:56:43.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:37:0)
[13:56:43.260] Timer tick, asking Buildbucket for the build status
[13:56:43.379] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:43.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:38:0) after 1m0s
[13:57:43.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:38:0)
[13:57:43.405] Timer tick, asking Buildbucket for the build status
[13:57:43.561] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:43.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:39:0) after 1m0s
[13:58:43.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:39:0)
[13:58:43.588] Timer tick, asking Buildbucket for the build status
[13:58:43.709] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:43.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:40:0) after 1m0s
[13:59:43.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:40:0)
[13:59:43.728] Timer tick, asking Buildbucket for the build status
[13:59:43.817] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:43.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:41:0) after 1m0s
[14:00:43.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:41:0)
[14:00:43.875] Timer tick, asking Buildbucket for the build status
[14:00:43.949] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:43.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:42:0) after 1m0s
[14:01:44.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:42:0)
[14:01:44.052] Timer tick, asking Buildbucket for the build status
[14:01:44.126] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:44.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:43:0) after 1m0s
[14:02:44.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:43:0)
[14:02:44.178] Timer tick, asking Buildbucket for the build status
[14:02:44.319] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:44.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:44:0) after 1m0s
[14:03:44.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:44:0)
[14:03:44.311] Timer tick, asking Buildbucket for the build status
[14:03:44.436] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:44.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:45:0) after 1m0s
[14:04:44.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:45:0)
[14:04:44.542] Timer tick, asking Buildbucket for the build status
[14:04:44.913] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:44.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:46:0) after 1m0s
[14:05:45.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:46:0)
[14:05:45.095] Timer tick, asking Buildbucket for the build status
[14:05:45.307] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:45.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:47:0) after 1m0s
[14:06:45.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:47:0)
[14:06:45.334] Timer tick, asking Buildbucket for the build status
[14:06:46.629] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:46.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:48:0) after 1m0s
[14:07:46.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:48:0)
[14:07:46.710] Timer tick, asking Buildbucket for the build status
[14:07:47.284] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:47.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:49:0) after 1m0s
[14:08:47.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:49:0)
[14:08:47.314] Timer tick, asking Buildbucket for the build status
[14:08:47.476] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:47.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:50:0) after 1m0s
[14:09:47.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:50:0)
[14:09:47.498] Timer tick, asking Buildbucket for the build status
[14:09:47.748] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:47.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:51:0) after 1m0s
[14:10:47.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:51:0)
[14:10:47.773] Timer tick, asking Buildbucket for the build status
[14:10:48.053] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:48.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:52:0) after 1m0s
[14:11:48.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:52:0)
[14:11:48.083] Timer tick, asking Buildbucket for the build status
[14:11:48.196] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:48.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:53:0) after 1m0s
[14:12:48.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:53:0)
[14:12:48.252] Timer tick, asking Buildbucket for the build status
[14:12:48.367] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:48.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:54:0) after 1m0s
[14:13:48.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:54:0)
[14:13:48.478] Timer tick, asking Buildbucket for the build status
[14:13:48.659] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:48.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:55:0) after 1m0s
[14:14:48.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:55:0)
[14:14:48.712] Timer tick, asking Buildbucket for the build status
[14:14:49.002] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:49.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:56:0) after 1m0s
[14:15:49.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:56:0)
[14:15:49.034] Timer tick, asking Buildbucket for the build status
[14:15:49.451] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:49.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:57:0) after 1m0s
[14:16:49.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:57:0)
[14:16:49.490] Timer tick, asking Buildbucket for the build status
[14:16:49.663] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:49.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:58:0) after 1m0s
[14:17:49.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:58:0)
[14:17:49.678] Timer tick, asking Buildbucket for the build status
[14:17:49.869] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:49.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:59:0) after 1m0s
[14:18:49.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:59:0)
[14:18:49.939] Timer tick, asking Buildbucket for the build status
[14:18:50.134] Build 8888475220099617328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:50.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053905282139121920:60:0) after 1m0s
[14:19:48.715] Received PubSub notification, asking Buildbucket for the build status
[14:19:49.002] Build 8888475220099617328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:19:49.002] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581689961182905",
"created_by": "project:chromium",
"created_ts": "1581686492785056",
"id": "8888475220099617328",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d75c6640c4c96925b9b3c3030c47798661f662fd\"}}",
"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-46-x843\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168597, \"got_angle_revision\": \"eaff904e72606609d215cc87b78d8a7ed99159e7\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d75c6640c4c96925b9b3c3030c47798661f662fd\", \"got_revision_cp\": \"refs/heads/master@{#741424}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"f9f999f5a2eb6dd586a1da03e6b400d044ae6022\", \"got_v8_revision\": \"142ac8d31d94082d90a1d2983db88f5730748185\", \"got_v8_revision_cp\": \"refs/heads/8.2.76@{#1}\", \"got_webrtc_revision\": \"e7c4f906516813252c8fbbff450b771bd6c14e1c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30521}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d75c6640c4c96925b9b3c3030c47798661f662fd\", \"swarm_hashes_refs/heads/master(at){#741424}_without_patch\": {\"accessibility_unittests\": \"74029b5c01aa93f7bace4c04116021d2e39fc8df\", \"angle_unittests\": \"3f64b0dee3aa541b3277653100b1301c84f44f6e\", \"app_shell_unittests\": \"40d0c7a7e171627a67e63f11de718afdfe503fab\", \"aura_unittests\": \"de0219e37d35b5c5fbeeae2be5c11f46b7cb4547\", \"base_unittests\": \"a942460c15b77a4b4605e3d51f6c7c206c792c7c\", \"base_util_unittests\": \"3418e595b77a8731689841138a355eb713280447\", \"blink_common_unittests\": \"218dd5e892eba681c68af10d0db654628fe45bed\", \"blink_fuzzer_unittests\": \"2b2bb83e508c6a56cd54039939f4cdeaacbe98e4\", \"blink_heap_unittests\": \"0c99aa2a7debb19af5ae3cf88fcfe0beeb4b3a20\", \"blink_platform_unittests\": \"623233b5c7423f8625b4a46469ff2ae7a6ff3a61\", \"blink_python_tests\": \"c840fda2891512d7fe443eb83ec69d9d920cd9aa\", \"blink_unittests\": \"e362319b63d7fea3b2196f72757135d6fdd59f23\", \"blink_web_tests\": \"223da519fd7c6c8fd283f25fbaa01928ca8e3a9e\", \"boringssl_crypto_tests\": \"cefc9904348a66f85343159d7fcc57d7e43b0fd9\", \"boringssl_ssl_tests\": \"1a3d136511a73954c422e769248f23d94a8f1f78\", \"browser_tests\": \"0348a310a4e894fc42888072a4f9b68afa764a7b\", \"cacheinvalidation_unittests\": \"a2f95d0e16edf193b7a1364c1cfca656b1da2fde\", \"capture_unittests\": \"58ad130718984fa799c31e2ec1240e8660ba90a5\", \"cast_unittests\": \"afdd8399bab3caa66b7f9f7ac3efdc40e0399cd0\", \"cc_unittests\": \"25b6a44b488d971f0557b41d23b187218eb3ade0\", \"chrome_app_unittests\": \"f30738365e21de3119d9199dde856e17252d50b5\", \"chromedriver_unittests\": \"be7d9edf65ca949f4fc510e7ebc923298c2bc5aa\", \"components_browsertests\": \"012d9354b5a69d9f27266a4e76c0cea67acba7b0\", \"components_unittests\": \"70e06f680913c7c276cf2766eaa874d5c32b05fd\", \"compositor_unittests\": \"67f4179cbcff76e241de928b6cb916b11ba4ec10\", \"content_browsertests\": \"c514f09a8c6b8dec0220a7721cc0ace0d0607137\", \"content_shell_crash_test\": \"f95b3b2a3dd3b7dd0325e015914225acb8f1f356\", \"content_unittests\": \"4bc892dfa14299906d3af01c1bdb821f2d656c40\", \"crashpad_tests\": \"fd6da114b8f66cf36f06cb9cbb33b854c414f8e0\", \"cronet_tests\": \"3a77a6d4a3899e1587547270d611cf6f2a4d029f\", \"cronet_unittests\": \"dd4219c0afca343196b46a6636e4f13876d7d5f9\", \"crypto_unittests\": \"0271d75d7d6a98967fa1ebcfde355363b764f7b5\", \"dbus_unittests\": \"5a98ea42a87c2e66295430e13b4df300ef8bbead\", \"device_unittests\": \"22129ec5ca0e24805ba50f2185b1e40848833c9e\", \"display_unittests\": \"1901e65c0e52a9afaf27511c58c5e878d221ec56\", \"events_unittests\": \"b2302d5802b1cf87d20f490c7e264f3ebe02b1a7\", \"extensions_browsertests\": \"e6bed6257c5ec12c8d418f7ce96b4ed72352194e\", \"extensions_unittests\": \"f39b57ff364254d723c159b8b9b4d96b2227fc32\", \"filesystem_service_unittests\": \"500edfcb1cbfd84b5d54ca8bb61d7ce35bd8260a\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"8a53d4a38378671e3a70e17babb8581cdc7cd615\", \"gfx_unittests\": \"d7314fae01775abd763f97c3b6b5beb786739ff8\", \"gin_unittests\": \"e63a869d2242ee48a662b949fd648f5864dfee5e\", \"google_apis_unittests\": \"4d68902e811fecd11fef45d20ff9c627a0a72e5d\", \"gpu_unittests\": \"3252cf761f259aad6f4109e3c1525b4d941c7f57\", \"grit_python_unittests\": \"314a136826c68f2b20f2d52ddf6f5e567311beb1\", \"gwp_asan_unittests\": \"6b488c70b505b2fddad79cc7062e2120d4319fb9\", \"headless_browsertests\": \"cb1ac74f565cca7467ff92995e1bb2d8b63ef96f\", \"headless_unittests\": \"0720153f2dc567a2358f301986def00f2aa82728\", \"interactive_ui_tests\": \"f6b3c4ebcc231fcae0da957542feb0bd098f4f07\", \"ipc_tests\": \"5118b3706e6102209a9f0920c80df9070946bb12\", \"jingle_unittests\": \"bf602c08b60a41c61299df18b5f486463f4e64c9\", \"latency_unittests\": \"32ec671d78d0e864d5e1e6f122ced9a89e0d952e\", \"libjingle_xmpp_unittests\": \"c1a23fb1efa54ce81e13cd6aa47f7d9428ba7178\", \"media_blink_unittests\": \"0e8b17f467feee08666e48ac73e6e381a968343f\", \"media_service_unittests\": \"525fa02f1c876258aee56da472279112b72d2a6c\", \"media_unittests\": \"8f40e3a6fd3aed143af8cc040c69f5ccbb3b7607\", \"message_center_unittests\": \"a695ad85b0e9755981a7c69b34402a1c63ae2d6e\", \"metrics_python_tests\": \"5fcb40e9903bf94b904af552ba65c20538dec7d5\", \"midi_unittests\": \"749cc8aa6382e5e037c81e18f36938707efb0e73\", \"mojo_core_unittests\": \"7dde525b7bbd9b770635ef09326f6e6dc803d185\", \"mojo_unittests\": \"2264d5e01478adb097e29660e978e2a75ab0fb01\", \"nacl_helper_nonsfi_unittests\": \"cb60b89f398b2a78942b3316e037e1fe004f0343\", \"nacl_loader_unittests\": \"3c5a2236f042c79254b1f9d0114dd8f19499d703\", \"native_theme_unittests\": \"92ba765786327755dd0c888103e59bf338ce325f\", \"net_unittests\": \"5cd8331f136b28dab88fbd84091b7378a1bb05ee\", \"pdf_unittests\": \"1e98edaab67e525a9a46fe4fd46f89395885d93d\", \"perfetto_unittests\": \"35fab65f38ec455e88a8b4b16aa39293063b77d6\", \"ppapi_unittests\": \"592a3ea96dc7bde73dc289bdbc52e666c4ff92fa\", \"printing_unittests\": \"7d172e5bb0600926a32436fd46f3d3be12fc9e54\", \"remoting_unittests\": \"cff2aea31c193d9cbb16fee98fd714084c8eadec\", \"sandbox_linux_unittests\": \"59676316b2761abd6c1abeb842849b300b031950\", \"service_manager_unittests\": \"9cc4d4b2025d1c8cafae6851552a16186b136196\", \"services_unittests\": \"6b91d379950d1af5708e73241091320a7514733c\", \"shell_dialogs_unittests\": \"3356ecb8bee3b49994c120c109582264e7f078fc\", \"skia_unittests\": \"c44cf441b8028c176a5a0d8d4134e0a00486dab1\", \"snapshot_unittests\": \"e1c54fc9d26a3b81ecb39e861d0d1e94a6597d1a\", \"sql_unittests\": \"36b46bc4b85ca2cd3047dd51a46e9e0b2483924f\", \"storage_unittests\": \"5b566a8a3a1f4064305165d2b02dbde83b3c4125\", \"sync_integration_tests\": \"84b469a9c2845e25b4cb60c5dfa05119867fa93d\", \"telemetry_gpu_unittests\": \"3affaa56c235866086b0b53dfdb4e655011bd34e\", \"telemetry_perf_unittests\": \"214731681ed0e113f7828b1162f75a761bf2af9f\", \"telemetry_unittests\": \"413289bd404936cf59410b2844fd033924b23e9c\", \"traffic_annotation_auditor_unittests\": \"f3b5345f28e78bb38fffd7edbd2b8ee33f44ec6e\", \"ui_base_unittests\": \"52f33d73df41c9ad59241c021fb742b010ee2683\", \"ui_touch_selection_unittests\": \"83f81d1edbe35479d7bdea5d96e9d93b4f09d1de\", \"unit_tests\": \"0afc13344582ab257d8fc7ea512b591c074266e5\", \"url_unittests\": \"b0c57a237e7f6db20ef06d8026fa493d705ca794\", \"views_perftests\": \"326cc2c252837e885ba240f04f42e0eefd2859c1\", \"views_unittests\": \"8ce623e476c9b9f3668ec3bdd763886d8f83f60e\", \"viz_unittests\": \"d6707999dba4da4c9d879da66b2517e7ac5a58a5\", \"vr_common_unittests\": \"cf697d5e6b35639cdb6a1bbcb525954278b45369\", \"vr_pixeltests\": \"2f14a20f5a6f802b8ee3633470fdea00a32ba168\", \"webdriver_wpt_tests\": \"d23563b19e964564088adff461a4f5a0109ce791\", \"weblayer_browsertests\": \"ec8093c835f7f260724458c082c91bab2467c873\", \"wm_unittests\": \"1fc0788f96069cf5babdf3ad25c8758027d481ee\", \"wtf_unittests\": \"2b67bc42f8a5038dd52e94acf8966f634cd03bcf\", \"xr_browser_tests\": \"ae68d253e6bcb6bce7ce534e876d3544428b5bf7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_341c32bd45a59798b0d31a376a872da37ddfa394c44785a08305266670677548_v2\", \"builder_4f073cad989671df25347297d55a43b2baed7923c7c8febe8eed874750cd540a_v2\", \"builder_859368e171259d521efea13da6023dc28f5117d74d565299fe323cf1e9b3ffc9_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_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-46-x843\"], \"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\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581686765168808",
"status": "COMPLETED",
"status_changed_ts": "1581689988128853",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168597",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d75c6640c4c96925b9b3c3030c47798661f662fd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d75c6640c4c96925b9b3c3030c47798661f662fd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053905282139121920",
"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/8888475220099617328/+/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:4a5cae1cb2de3e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581689988134537",
"url": "https://ci.chromium.org/b/8888475220099617328",
"utcnow_ts": "1581689988986628"
}
}
[14:19:49.002] Invocation finished in 58m17.545335094s with status SUCCEEDED