[07:14:18.823] New invocation is queued and will start shortly
[07:14:20.364] Starting the invocation (attempt 1)
[07:14:20.408] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:14:20.408] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:14:20.408] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060723157527309072",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e560578e6cabfb539e3af1e175b7f876f97e7f8d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060723157527309072",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e560578e6cabfb539e3af1e175b7f876f97e7f8d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e560578e6cabfb539e3af1e175b7f876f97e7f8d",
"gitiles_ref:refs/heads/master"
]
}
[07:14:23.064] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575184461952875",
"id": "8895293093582454512",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e560578e6cabfb539e3af1e175b7f876f97e7f8d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575184462880419",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165511",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e560578e6cabfb539e3af1e175b7f876f97e7f8d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e560578e6cabfb539e3af1e175b7f876f97e7f8d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060723157527309072",
"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/8895293093582454512/+/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": "1575184462880519",
"url": "https://ci.chromium.org/b/8895293093582454512",
"utcnow_ts": "1575184463056662"
}
}
[07:14:23.064] Task URL: https://ci.chromium.org/b/8895293093582454512
[07:14:23.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:2:0) after 1m0s
[07:15:28.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:2:0)
[07:15:28.456] Timer tick, asking Buildbucket for the build status
[07:15:29.554] Build 8895293093582454512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:29.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:3:0) after 1m0s
[07:16:29.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:3:0)
[07:16:29.766] Timer tick, asking Buildbucket for the build status
[07:16:29.955] Build 8895293093582454512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:29.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:4:0) after 1m0s
[07:17:30.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:4:0)
[07:17:30.027] Timer tick, asking Buildbucket for the build status
[07:17:30.273] Build 8895293093582454512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:30.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:5:0) after 1m0s
[07:18:30.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:5:0)
[07:18:30.405] Timer tick, asking Buildbucket for the build status
[07:18:30.648] Build 8895293093582454512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:30.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:6:0) after 1m0s
[07:19:02.539] Received PubSub notification, asking Buildbucket for the build status
[07:19:02.689] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:30.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:6:0)
[07:19:30.700] Timer tick, asking Buildbucket for the build status
[07:19:31.093] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:31.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:8:0) after 1m0s
[07:20:31.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:8:0)
[07:20:31.167] Timer tick, asking Buildbucket for the build status
[07:20:31.345] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:31.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:9:0) after 1m0s
[07:21:31.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:9:0)
[07:21:31.614] Timer tick, asking Buildbucket for the build status
[07:21:31.791] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:31.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:10:0) after 1m0s
[07:22:32.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:10:0)
[07:22:32.038] Timer tick, asking Buildbucket for the build status
[07:22:32.410] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:32.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:11:0) after 1m0s
[07:23:32.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:11:0)
[07:23:32.573] Timer tick, asking Buildbucket for the build status
[07:23:33.653] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:33.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:12:0) after 1m0s
[07:24:34.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:12:0)
[07:24:34.040] Timer tick, asking Buildbucket for the build status
[07:24:34.256] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:34.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:13:0) after 1m0s
[07:25:34.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:13:0)
[07:25:34.503] Timer tick, asking Buildbucket for the build status
[07:25:34.784] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:34.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:14:0) after 1m0s
[07:26:34.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:14:0)
[07:26:34.780] Timer tick, asking Buildbucket for the build status
[07:26:35.120] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:35.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:15:0) after 1m0s
[07:27:35.230] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:15:0)
[07:27:35.230] Timer tick, asking Buildbucket for the build status
[07:27:35.699] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:35.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:16:0) after 1m0s
[07:28:35.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:16:0)
[07:28:35.691] Timer tick, asking Buildbucket for the build status
[07:28:36.234] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:36.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:17:0) after 1m0s
[07:29:36.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:17:0)
[07:29:36.258] Timer tick, asking Buildbucket for the build status
[07:29:36.560] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:36.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:18:0) after 1m0s
[07:30:36.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:18:0)
[07:30:36.686] Timer tick, asking Buildbucket for the build status
[07:30:37.588] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:37.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:19:0) after 1m0s
[07:31:37.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:19:0)
[07:31:37.667] Timer tick, asking Buildbucket for the build status
[07:31:37.948] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:37.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:20:0) after 1m0s
[07:32:37.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:20:0)
[07:32:37.968] Timer tick, asking Buildbucket for the build status
[07:32:38.161] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:38.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:21:0) after 1m0s
[07:33:38.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:21:0)
[07:33:38.220] Timer tick, asking Buildbucket for the build status
[07:33:39.161] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:39.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:22:0) after 1m0s
[07:34:39.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:22:0)
[07:34:39.184] Timer tick, asking Buildbucket for the build status
[07:34:40.128] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:40.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:23:0) after 1m0s
[07:35:40.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:23:0)
[07:35:40.249] Timer tick, asking Buildbucket for the build status
[07:35:40.544] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:40.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:24:0) after 1m0s
[07:36:40.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:24:0)
[07:36:40.564] Timer tick, asking Buildbucket for the build status
[07:36:41.113] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:41.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:25:0) after 1m0s
[07:37:41.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:25:0)
[07:37:41.183] Timer tick, asking Buildbucket for the build status
[07:37:41.417] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:41.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:26:0) after 1m0s
[07:38:41.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:26:0)
[07:38:41.441] Timer tick, asking Buildbucket for the build status
[07:38:41.667] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:41.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:27:0) after 1m0s
[07:39:41.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:27:0)
[07:39:41.741] Timer tick, asking Buildbucket for the build status
[07:39:42.026] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:42.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:28:0) after 1m0s
[07:40:42.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:28:0)
[07:40:42.128] Timer tick, asking Buildbucket for the build status
[07:40:42.646] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:42.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:29:0) after 1m0s
[07:41:42.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:29:0)
[07:41:42.771] Timer tick, asking Buildbucket for the build status
[07:41:42.997] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:42.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:30:0) after 1m0s
[07:42:43.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:30:0)
[07:42:43.024] Timer tick, asking Buildbucket for the build status
[07:42:43.189] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:43.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:31:0) after 1m0s
[07:43:43.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:31:0)
[07:43:43.273] Timer tick, asking Buildbucket for the build status
[07:43:43.663] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:43.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:32:0) after 1m0s
[07:44:44.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:32:0)
[07:44:44.116] Timer tick, asking Buildbucket for the build status
[07:44:44.280] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:44.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:33:0) after 1m0s
[07:45:44.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:33:0)
[07:45:44.477] Timer tick, asking Buildbucket for the build status
[07:45:44.717] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:44.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:34:0) after 1m0s
[07:46:44.947] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:34:0)
[07:46:44.947] Timer tick, asking Buildbucket for the build status
[07:46:45.555] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:45.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:35:0) after 1m0s
[07:47:45.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:35:0)
[07:47:45.825] Timer tick, asking Buildbucket for the build status
[07:47:45.967] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:45.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:36:0) after 1m0s
[07:48:46.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:36:0)
[07:48:46.099] Timer tick, asking Buildbucket for the build status
[07:48:46.421] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:46.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:37:0) after 1m0s
[07:49:46.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:37:0)
[07:49:46.436] Timer tick, asking Buildbucket for the build status
[07:49:46.714] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:46.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:38:0) after 1m0s
[07:50:46.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:38:0)
[07:50:46.868] Timer tick, asking Buildbucket for the build status
[07:50:47.118] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:39:0) after 1m0s
[07:51:47.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:39:0)
[07:51:47.241] Timer tick, asking Buildbucket for the build status
[07:51:48.022] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:48.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:40:0) after 1m0s
[07:52:48.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:40:0)
[07:52:48.001] Timer tick, asking Buildbucket for the build status
[07:52:48.798] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:48.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:41:0) after 1m0s
[07:53:48.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:41:0)
[07:53:48.845] Timer tick, asking Buildbucket for the build status
[07:53:49.279] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:49.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:42:0) after 1m0s
[07:54:49.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:42:0)
[07:54:49.416] Timer tick, asking Buildbucket for the build status
[07:54:50.167] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:50.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:43:0) after 1m0s
[07:55:50.172] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:43:0)
[07:55:50.172] Timer tick, asking Buildbucket for the build status
[07:55:50.538] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:50.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:44:0) after 1m0s
[07:56:50.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:44:0)
[07:56:50.667] Timer tick, asking Buildbucket for the build status
[07:56:50.822] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:50.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:45:0) after 1m0s
[07:57:50.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:45:0)
[07:57:50.845] Timer tick, asking Buildbucket for the build status
[07:57:51.029] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:51.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:46:0) after 1m0s
[07:58:51.153] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:46:0)
[07:58:51.153] Timer tick, asking Buildbucket for the build status
[07:58:51.613] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:51.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:47:0) after 1m0s
[07:59:51.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:47:0)
[07:59:51.640] Timer tick, asking Buildbucket for the build status
[07:59:51.831] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:51.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:48:0) after 1m0s
[08:00:51.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:48:0)
[08:00:51.893] Timer tick, asking Buildbucket for the build status
[08:00:52.601] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:52.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:49:0) after 1m0s
[08:01:52.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:49:0)
[08:01:52.587] Timer tick, asking Buildbucket for the build status
[08:01:52.895] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:52.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:50:0) after 1m0s
[08:02:52.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:50:0)
[08:02:52.962] Timer tick, asking Buildbucket for the build status
[08:02:53.823] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:53.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:51:0) after 1m0s
[08:03:53.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:51:0)
[08:03:53.856] Timer tick, asking Buildbucket for the build status
[08:03:54.104] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:54.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:52:0) after 1m0s
[08:04:54.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:52:0)
[08:04:54.227] Timer tick, asking Buildbucket for the build status
[08:04:54.439] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:54.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:53:0) after 1m0s
[08:05:54.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:53:0)
[08:05:54.469] Timer tick, asking Buildbucket for the build status
[08:05:54.722] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:54:0) after 1m0s
[08:06:55.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:54:0)
[08:06:55.117] Timer tick, asking Buildbucket for the build status
[08:06:55.713] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:55.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:55:0) after 1m0s
[08:07:56.031] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:55:0)
[08:07:56.031] Timer tick, asking Buildbucket for the build status
[08:07:56.949] Build 8895293093582454512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:56.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060723157527309072:56:0) after 1m0s
[08:08:28.026] Received PubSub notification, asking Buildbucket for the build status
[08:08:28.500] Build 8895293093582454512: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:08:28.500] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575187707215693",
"created_by": "project:chromium",
"created_ts": "1575184461952875",
"id": "8895293093582454512",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e560578e6cabfb539e3af1e175b7f876f97e7f8d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-9-oe0h\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165511, \"got_angle_revision\": \"bc82fb14aab4b1238cdb7291bdd34816863f26b8\", \"got_dawn_revision\": \"969df2b3a21c126b2e0015ce2392c135f32a6a08\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"e560578e6cabfb539e3af1e175b7f876f97e7f8d\", \"got_revision_cp\": \"refs/heads/master@{#720346}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b64fbfec4dcd3f81c776198641b1fc71ac8d64a4\", \"got_v8_revision\": \"adfb6ba32d881a5bba73f9c7121ca9f8dba881b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.418@{#1}\", \"got_webrtc_revision\": \"89313451d8e2338845716b0ab8760ed0552580f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29962}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e560578e6cabfb539e3af1e175b7f876f97e7f8d\", \"swarm_hashes_refs/heads/master(at){#720346}_without_patch\": {\"accessibility_unittests\": \"a1d0134ef58ba98435a8432e4a4b040fb142856a\", \"angle_unittests\": \"235c4632ffd4257b6e9148f4d760bd783e109a38\", \"app_shell_unittests\": \"5f8ea2a47f1fc1a09f9667a04bb601d7893e64fe\", \"aura_unittests\": \"ba05037acbd9231761e8967cac22334029f1537c\", \"base_unittests\": \"e568fc6dfa21db76b11ec506ec755ec4b63d2dfd\", \"base_util_unittests\": \"c80c48921b5eb17aeaae5aa0e4ca195145ab8ff8\", \"blink_common_unittests\": \"8b58031d703096120b708592bb7b4503fe7563db\", \"blink_fuzzer_unittests\": \"384c8a777953af45627b0d7bddfa5df80f6eeca1\", \"blink_heap_unittests\": \"64e67a026dfbca8cd18c973cfb76fb913a5a7f7f\", \"blink_platform_unittests\": \"0608be2c1ed95160a2c779192745d1c04e2b8113\", \"blink_python_tests\": \"c515c2a8cac72b8261cc28202c7767074b84ff0f\", \"blink_unittests\": \"971d04896911231177b316709b23ace0bfb0dba2\", \"blink_web_tests_exparchive\": \"446d01b5540ccb2d9a70e5c502af4fa318fcb02a\", \"boringssl_crypto_tests\": \"45f65880cc7396d31b217f0a292b4d69e9c3040c\", \"boringssl_ssl_tests\": \"c95ec5671a99d405745b32d5fd9b3c99fd793c36\", \"browser_tests\": \"a8dadbbdf4667f52d6ff46d65e7e1dfbf44ec3f2\", \"cacheinvalidation_unittests\": \"d819e97a8f022b1f2da34452aec61df7bf6268c5\", \"capture_unittests\": \"6649df9cc4ecffdaf74938128875573eac88d169\", \"cast_unittests\": \"bc85584a5916d58a1f8d3feea23a19106539f45f\", \"cc_unittests\": \"6f15b7ebdc498627fdf1a70e819ace6b164667bb\", \"chrome_app_unittests\": \"3ca0bb678c109e5209fd2efb9e525dd53879ac28\", \"chromedriver_unittests\": \"cbb88145288194501420c26dd86580292f7b6069\", \"color_unittests\": \"eed229b2c760d7397c460ed6370ddabcc13a6475\", \"components_browsertests\": \"6e9be978b118817d12832e553e5aa18a5ef70184\", \"components_unittests\": \"4e69891ea567a11e748215e711d5e84bfa8bf474\", \"compositor_unittests\": \"d2098e0e288cc01407cc470c05f27bc6b660bc72\", \"content_browsertests\": \"86b4187efbfc087f7069ecb53feb9e38d8556fa2\", \"content_shell_crash_test\": \"7dd0d70e573e846696b85e06e057fe9857776035\", \"content_unittests\": \"43dde281b71ad5a16da65bb7c758aeeab4a31f69\", \"crashpad_tests\": \"b80733bd5b5494ff23aa218421e69b86361182b8\", \"cronet_tests\": \"bae1e2485c697866d64353b78116a4c5090bb6ff\", \"cronet_unittests\": \"10ac5be3b30669f14c76e34dd63f81d6d923a90f\", \"crypto_unittests\": \"7f05a21f9d0f2d8abd81ad5213349fe39a70e78a\", \"dbus_unittests\": \"6cb12b999d84c07a4faef9b2350edf558ac15bd7\", \"device_unittests\": \"58da90361575eb8725cedc6c44b7fd50689308e7\", \"devtools_lint_check\": \"66d566c3b2871e097a0c69c1dd8ecabc79df1a1c\", \"devtools_type_check\": \"56f40a40af2b8e44ad647e88053a97bb50847909\", \"display_unittests\": \"95d41cc43c0bd52826324998099722f2a52bfecf\", \"events_unittests\": \"27c2d42d2f0563ed9430518ee4c4d0be20713ffb\", \"extensions_browsertests\": \"f315dbf5b49a3bd3371696e72629f257f9fe3ed5\", \"extensions_unittests\": \"248c16c5b93c4111159ddc2a3076804429695272\", \"filesystem_service_unittests\": \"88ccbcb263d8319bdc41fbc3c7fc7eeee0a94b0d\", \"flatbuffers_unittests\": \"96a0b5c2dbd3fc6b7b34efea95740d4aa2310fb5\", \"gcm_unit_tests\": \"23e0a203d87eeb9671f86f23cd0264bd56b506fa\", \"gfx_unittests\": \"68331e38ead27fcd970bc7527a77bdb11ba48904\", \"gin_unittests\": \"b8a48da0a58d737169326f7392ad2f44596c2035\", \"google_apis_unittests\": \"8cc21a0d24a9075cc563cc197e251f139cb80259\", \"gpu_unittests\": \"16c003e7e83cae284d5c0bb6d6d0e84b4a442f8b\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"49c45393d90e9a9535b9b5d5237f1c58e3f97348\", \"headless_browsertests\": \"53fac947092475306a2510188e1891dc64db1a17\", \"headless_unittests\": \"ccaa4aa8d60afb9821028b42e7f3d558b000e91b\", \"interactive_ui_tests\": \"2570a0748b7599a705dde28b8ce71329d2029ad7\", \"ipc_tests\": \"214f9dee1da639f2f8ee6efe2460084f2c85678e\", \"jingle_unittests\": \"382f526fcffcab05f8da589b6ec4a7a75d81dd35\", \"latency_unittests\": \"6aba01288fd00fd1cd1787dc6d16b8e5051733e7\", \"libjingle_xmpp_unittests\": \"25202ee62df3dfb17fc2b398e30921c1dedbb0f6\", \"media_blink_unittests\": \"e48a00ad4f539de5af6bd34c8e6fef2da709d7df\", \"media_service_unittests\": \"f411da26dceeccfbd771a0bbd66b4e6efbd9c02b\", \"media_unittests\": \"b2c99a286ff519105828f5be03fa1d64aec58333\", \"message_center_unittests\": \"be1f6952d82998e7d692bb2c291bdb222bef961f\", \"metrics_python_tests\": \"4d0fc5d8db43b6446f978ec3b0f2e62dfd53b5f2\", \"midi_unittests\": \"374257057888408602aa02fff6606ee7157a8d80\", \"mojo_core_unittests\": \"756835757a6c17fefdafa32cfe31da28543cee97\", \"mojo_unittests\": \"9d2d5e8a810d4d6331970a5371b09c9f7bb50e48\", \"nacl_helper_nonsfi_unittests\": \"8bbe69ffa19915e0927e11f6a3261d1cfbba8631\", \"nacl_loader_unittests\": \"e8c17a75628b07cca4a1204dd7471a291b4d5c0d\", \"native_theme_unittests\": \"e1616acb2933ffa1f335b2b4e5b671bea75e736e\", \"net_unittests\": \"a46d525cfc89868cab8b062cf41123bc5a655cb5\", \"pdf_unittests\": \"4054448105fb8d2691a24a0eab61befbaab01e61\", \"perfetto_unittests\": \"1bafa3f62e2063aea04752afe3c2f5627432f4bd\", \"ppapi_unittests\": \"8eedc64e6ddf8b53daea707a06d240de9e13120f\", \"printing_unittests\": \"07d634e00894a3bd31a6fa05664a868e4ba6c2e9\", \"remoting_unittests\": \"9fa65041646cd19f2f680a1f1d32ae3dd2804155\", \"sandbox_linux_unittests\": \"94c21acf3fa7feef46bb6c212a08840aa27cae4f\", \"service_manager_unittests\": \"25e5593962bb1d25b37c68c491082d86612d3d90\", \"services_unittests\": \"4c9b1a3c91ebe1f668a467b0618e14180a0069e3\", \"shell_dialogs_unittests\": \"9d6d66a8879ac2f64912d8335ecd4ff0951d83fc\", \"skia_unittests\": \"6a586d30da28075e8b05b958f316bd93a4d4b73a\", \"snapshot_unittests\": \"fda1d9a9ec3ab3393e37be85e1e99a921588612c\", \"sql_unittests\": \"c7030ad5acdd128bad6229ec6f0cab3152d7970c\", \"storage_unittests\": \"5ce94e0c16d4cb2e21ba0c500a1730079b593dc9\", \"sync_integration_tests\": \"9b4dacfd57b24a420db7d2d31ecd60356e21ad8f\", \"telemetry_gpu_unittests\": \"873380cad669bd1ac887befc8507429817e163eb\", \"telemetry_perf_unittests\": \"1246391d7363d0296bb8b1ac644516bfe217f5a1\", \"telemetry_unittests\": \"61a4c3f240bf9bc6deaa5a675444102fc22bf030\", \"traffic_annotation_auditor_unittests\": \"d3030e232321d9eae7034bb4374042d699d11ea7\", \"ui_base_unittests\": \"530000f01c6f8c0029424f03cfd3feb2275d6f19\", \"ui_touch_selection_unittests\": \"667a2809f69d5efd803be399e6fc69ba67fedc1e\", \"unit_tests\": \"9f6f2f6fb178056014a30a68a177e811290e1d3b\", \"url_unittests\": \"77529363a1717ef5def6996915b9d4608dd46d69\", \"views_perftests\": \"9a65121126dcc386c99c3ecfddac032d46fc9f75\", \"views_unittests\": \"8328bc2bda10d361d7f8d8670561eb890d333de1\", \"viz_unittests\": \"ded6f7db943008fdb67c1514e6376ce74ced0f2b\", \"vr_common_unittests\": \"5833bd7381e098869961a83c06ee2c5516d92b09\", \"vr_pixeltests\": \"2d038a3140e3831496bffbfdbc335e53ed18b6a2\", \"webdriver_wpt_tests\": \"4857eb0e0a2dce654283ed6e64f68d333f4ec953\", \"weblayer_browsertests\": \"c5affa31afba59746c3c8c6d5d694674fa83dd91\", \"wm_unittests\": \"01a01f9656d18127872eb1c0a0098ccaff1c1923\", \"wtf_unittests\": \"66b8ac5b4a44d4272747e678c00be32ede8f4a93\", \"xr_browser_tests\": \"5c69d80838e073bc74857333fbee509cd5810213\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_662609c3a18ad850d61ba5f58749e60478bc4d9d576475e0c738a1c9e2d8d890_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-9-oe0h\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4662-e230705\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575184741951669",
"status": "COMPLETED",
"status_changed_ts": "1575187707583483",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165511",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e560578e6cabfb539e3af1e175b7f876f97e7f8d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e560578e6cabfb539e3af1e175b7f876f97e7f8d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060723157527309072",
"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/8895293093582454512/+/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:48d920fe0849a610",
"user_agent:luci-scheduler"
],
"updated_ts": "1575187707587406",
"url": "https://ci.chromium.org/b/8895293093582454512",
"utcnow_ts": "1575187708481740"
}
}
[08:08:28.500] Invocation finished in 54m9.694132473s with status SUCCEEDED