[18:36:10.289] New invocation is queued and will start shortly
[18:36:11.856] Starting the invocation (attempt 1)
[18:36:11.936] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:36:11.936] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:36:11.937] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059230707311329120",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6981e34204fb3a288ae94eeb373b1fed92cda1c7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059230707311329120",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6981e34204fb3a288ae94eeb373b1fed92cda1c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6981e34204fb3a288ae94eeb373b1fed92cda1c7",
"gitiles_ref:refs/heads/master"
]
}
[18:36:12.839] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576607772178263",
"id": "8893800644638613936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6981e34204fb3a288ae94eeb373b1fed92cda1c7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576607772603232",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166218",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6981e34204fb3a288ae94eeb373b1fed92cda1c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6981e34204fb3a288ae94eeb373b1fed92cda1c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059230707311329120",
"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/8893800644638613936/+/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": "1576607772603338",
"url": "https://ci.chromium.org/b/8893800644638613936",
"utcnow_ts": "1576607772829557"
}
}
[18:36:12.839] Task URL: https://ci.chromium.org/b/8893800644638613936
[18:36:12.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:2:0) after 1m0s
[18:37:12.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:2:0)
[18:37:12.889] Timer tick, asking Buildbucket for the build status
[18:37:13.710] Build 8893800644638613936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:13.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:3:0) after 1m0s
[18:38:13.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:3:0)
[18:38:13.785] Timer tick, asking Buildbucket for the build status
[18:38:14.065] Build 8893800644638613936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:14.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:4:0) after 1m0s
[18:39:14.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:4:0)
[18:39:14.079] Timer tick, asking Buildbucket for the build status
[18:39:14.473] Build 8893800644638613936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:14.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:5:0) after 1m0s
[18:40:14.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:5:0)
[18:40:14.518] Timer tick, asking Buildbucket for the build status
[18:40:15.732] Build 8893800644638613936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:15.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:6:0) after 1m0s
[18:41:11.093] Received PubSub notification, asking Buildbucket for the build status
[18:41:11.493] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:15.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:6:0)
[18:41:15.821] Timer tick, asking Buildbucket for the build status
[18:41:17.259] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:17.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:8:0) after 1m0s
[18:42:17.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:8:0)
[18:42:17.282] Timer tick, asking Buildbucket for the build status
[18:42:17.608] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:17.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:9:0) after 1m0s
[18:43:17.662] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:9:0)
[18:43:17.662] Timer tick, asking Buildbucket for the build status
[18:43:18.191] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:18.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:10:0) after 1m0s
[18:44:18.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:10:0)
[18:44:18.249] Timer tick, asking Buildbucket for the build status
[18:44:18.555] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:18.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:11:0) after 1m0s
[18:45:18.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:11:0)
[18:45:18.649] Timer tick, asking Buildbucket for the build status
[18:45:19.944] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:19.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:12:0) after 1m0s
[18:46:20.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:12:0)
[18:46:20.027] Timer tick, asking Buildbucket for the build status
[18:46:20.693] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:20.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:13:0) after 1m0s
[18:47:20.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:13:0)
[18:47:20.752] Timer tick, asking Buildbucket for the build status
[18:47:21.914] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:21.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:14:0) after 1m0s
[18:48:21.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:14:0)
[18:48:21.965] Timer tick, asking Buildbucket for the build status
[18:48:22.567] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:15:0) after 1m0s
[18:49:22.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:15:0)
[18:49:22.587] Timer tick, asking Buildbucket for the build status
[18:49:24.962] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:24.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:16:0) after 1m0s
[18:50:24.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:16:0)
[18:50:24.965] Timer tick, asking Buildbucket for the build status
[18:50:25.172] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:25.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:17:0) after 1m0s
[18:51:25.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:17:0)
[18:51:25.210] Timer tick, asking Buildbucket for the build status
[18:51:25.443] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:25.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:18:0) after 1m0s
[18:52:25.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:18:0)
[18:52:25.523] Timer tick, asking Buildbucket for the build status
[18:52:26.768] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:26.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:19:0) after 1m0s
[18:53:26.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:19:0)
[18:53:26.828] Timer tick, asking Buildbucket for the build status
[18:53:27.506] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:20:0) after 1m0s
[18:54:27.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:20:0)
[18:54:27.559] Timer tick, asking Buildbucket for the build status
[18:54:27.867] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:27.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:21:0) after 1m0s
[18:55:27.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:21:0)
[18:55:27.912] Timer tick, asking Buildbucket for the build status
[18:55:28.182] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:28.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:22:0) after 1m0s
[18:56:28.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:22:0)
[18:56:28.251] Timer tick, asking Buildbucket for the build status
[18:56:28.603] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:28.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:23:0) after 1m0s
[18:57:28.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:23:0)
[18:57:28.593] Timer tick, asking Buildbucket for the build status
[18:57:29.002] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:29.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:24:0) after 1m0s
[18:58:29.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:24:0)
[18:58:29.024] Timer tick, asking Buildbucket for the build status
[18:58:29.649] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:29.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:25:0) after 1m0s
[18:59:29.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:25:0)
[18:59:29.832] Timer tick, asking Buildbucket for the build status
[18:59:30.327] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:30.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:26:0) after 1m0s
[19:00:30.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:26:0)
[19:00:30.399] Timer tick, asking Buildbucket for the build status
[19:00:30.825] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:30.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:27:0) after 1m0s
[19:01:30.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:27:0)
[19:01:30.912] Timer tick, asking Buildbucket for the build status
[19:01:31.138] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:31.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:28:0) after 1m0s
[19:02:31.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:28:0)
[19:02:31.268] Timer tick, asking Buildbucket for the build status
[19:02:31.560] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:31.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:29:0) after 1m0s
[19:03:31.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:29:0)
[19:03:31.671] Timer tick, asking Buildbucket for the build status
[19:03:31.848] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:31.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:30:0) after 1m0s
[19:04:32.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:30:0)
[19:04:32.001] Timer tick, asking Buildbucket for the build status
[19:04:34.653] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:34.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:31:0) after 1m0s
[19:05:34.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:31:0)
[19:05:34.741] Timer tick, asking Buildbucket for the build status
[19:05:35.402] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:35.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:32:0) after 1m0s
[19:06:35.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:32:0)
[19:06:35.420] Timer tick, asking Buildbucket for the build status
[19:06:35.587] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:35.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:33:0) after 1m0s
[19:07:35.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:33:0)
[19:07:35.677] Timer tick, asking Buildbucket for the build status
[19:07:35.901] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:35.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:34:0) after 1m0s
[19:08:36.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:34:0)
[19:08:36.231] Timer tick, asking Buildbucket for the build status
[19:08:36.413] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:36.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:35:0) after 1m0s
[19:09:36.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:35:0)
[19:09:36.799] Timer tick, asking Buildbucket for the build status
[19:09:37.146] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:37.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:36:0) after 1m0s
[19:10:37.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:36:0)
[19:10:37.671] Timer tick, asking Buildbucket for the build status
[19:10:37.949] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:37.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:37:0) after 1m0s
[19:11:38.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:37:0)
[19:11:38.099] Timer tick, asking Buildbucket for the build status
[19:11:38.833] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:38.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:38:0) after 1m0s
[19:12:38.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:38:0)
[19:12:38.886] Timer tick, asking Buildbucket for the build status
[19:12:40.467] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:40.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:39:0) after 1m0s
[19:13:40.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:39:0)
[19:13:40.510] Timer tick, asking Buildbucket for the build status
[19:13:40.813] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:40.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:40:0) after 1m0s
[19:14:40.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:40:0)
[19:14:40.848] Timer tick, asking Buildbucket for the build status
[19:14:47.924] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:47.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:41:0) after 1m0s
[19:15:48.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:41:0)
[19:15:48.012] Timer tick, asking Buildbucket for the build status
[19:15:48.822] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:48.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:42:0) after 1m0s
[19:16:49.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:42:0)
[19:16:49.014] Timer tick, asking Buildbucket for the build status
[19:16:49.796] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:49.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:43:0) after 1m0s
[19:17:49.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:43:0)
[19:17:49.809] Timer tick, asking Buildbucket for the build status
[19:17:50.688] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:50.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:44:0) after 1m0s
[19:18:50.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:44:0)
[19:18:50.710] Timer tick, asking Buildbucket for the build status
[19:18:50.937] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:50.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:45:0) after 1m0s
[19:19:50.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:45:0)
[19:19:50.919] Timer tick, asking Buildbucket for the build status
[19:19:51.125] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:51.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:46:0) after 1m0s
[19:20:51.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:46:0)
[19:20:51.156] Timer tick, asking Buildbucket for the build status
[19:20:51.785] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:51.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:47:0) after 1m0s
[19:21:51.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:47:0)
[19:21:51.838] Timer tick, asking Buildbucket for the build status
[19:21:53.756] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:53.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:48:0) after 1m0s
[19:22:53.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:48:0)
[19:22:53.809] Timer tick, asking Buildbucket for the build status
[19:22:54.346] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:54.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:49:0) after 1m0s
[19:23:54.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:49:0)
[19:23:54.461] Timer tick, asking Buildbucket for the build status
[19:23:55.440] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:55.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:50:0) after 1m0s
[19:24:55.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:50:0)
[19:24:55.555] Timer tick, asking Buildbucket for the build status
[19:24:56.119] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:56.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:51:0) after 1m0s
[19:25:56.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:51:0)
[19:25:56.232] Timer tick, asking Buildbucket for the build status
[19:25:57.731] Build 8893800644638613936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:57.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059230707311329120:52:0) after 1m0s
[19:26:12.033] Received PubSub notification, asking Buildbucket for the build status
[19:26:12.162] Build 8893800644638613936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:26:12.162] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576610771363417",
"created_by": "project:chromium",
"created_ts": "1576607772178263",
"id": "8893800644638613936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6981e34204fb3a288ae94eeb373b1fed92cda1c7\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-99-tblm\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166218, \"got_angle_revision\": \"7587588595901010a7b8d8683d06796ae420edb8\", \"got_dawn_revision\": \"1bbbe8f52da580bd245af733e068eaabacf72731\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"6981e34204fb3a288ae94eeb373b1fed92cda1c7\", \"got_revision_cp\": \"refs/heads/master@{#725608}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"24c49ddde89ca50ad656e672973575a528c8ba48\", \"got_v8_revision\": \"3e618bf6f5df3bdcb906db22d65671971c74038d\", \"got_v8_revision_cp\": \"refs/heads/8.1.48@{#1}\", \"got_webrtc_revision\": \"6fd58b338859d17919a76494ac50463510e0fc07\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30107}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6981e34204fb3a288ae94eeb373b1fed92cda1c7\", \"swarm_hashes_refs/heads/master(at){#725608}_without_patch\": {\"accessibility_unittests\": \"4e2bebffaf2a7cb5234f01a74777e0a06043a6cb\", \"angle_unittests\": \"2ec4bede37a3e6edcd72621720a49f3a7223c553\", \"app_shell_unittests\": \"1b95634ae459036fc67a8dfa1a648a8da9a1748f\", \"aura_unittests\": \"48235589569cdc79a577221d219f838edd8485c6\", \"base_unittests\": \"0cccf2a4c8c0a58ec6887ebc5b4d50dcf629c79f\", \"base_util_unittests\": \"6d47ef680abe61d44f5cab8b4e55c38a1d4183fc\", \"blink_common_unittests\": \"1491d025aba1eb91526bb702e293dc36347f5ab5\", \"blink_fuzzer_unittests\": \"a848ea62a1e5908692ab2481dc13cbc217f0de1f\", \"blink_heap_unittests\": \"318549097fceb9633d480a54244b801734ae6f57\", \"blink_platform_unittests\": \"dec1d443abe2be0a4e36333715ee1b02a18cfc53\", \"blink_python_tests\": \"2b83eea7ca1cf7de0726218220abec798b5d3f8b\", \"blink_unittests\": \"3b909705470abbb0ad31db90778b64cf20465405\", \"blink_web_tests\": \"3145bcb0931aafd22138e3f6ad80201459dc1fbf\", \"boringssl_crypto_tests\": \"512f27dcad19c31bca5dc79a7b06a39e090aff69\", \"boringssl_ssl_tests\": \"afffb3d16800d0162f3bb49b2ecb9583c63da7f3\", \"browser_tests\": \"fbab197970accd2c2147a2cf1ab3264027d5883c\", \"cacheinvalidation_unittests\": \"dc1268853e23ce14caf206e0e5add6a9e4b0ecb6\", \"capture_unittests\": \"f506105dd68b1011c93dadf76dda57596a1eacf9\", \"cast_unittests\": \"8e7f7b90c441cc47b722135a2721bc829f23f6df\", \"cc_unittests\": \"e0e8c4f4c32a07524f87910dd4b7e4e70df9e8a4\", \"chrome_app_unittests\": \"a57e18eadba6848c0677631c02cbf24e20e0a9bb\", \"chromedriver_unittests\": \"eca51e4eef364cd65fea0ddc32af05cbbd28841e\", \"components_browsertests\": \"b79244c7f28353ce08ddb8fc97d5e3eb4478b089\", \"components_unittests\": \"d027c40f98d474c6c43682d2465b79869d56aa40\", \"compositor_unittests\": \"5e06112edfbca83cbdea5691b9fb950f01d0e33a\", \"content_browsertests\": \"27f93fdfbb4a320df7a18c080556248a5e63aa8e\", \"content_shell_crash_test\": \"a92c79ed7f9775311a16021f699d228e79d542da\", \"content_unittests\": \"3133b7f00a90491867896f3021c4189eca16461b\", \"crashpad_tests\": \"1082d9e935a9fef677d445a5c74c9a0d92909982\", \"cronet_tests\": \"2b7828cbc6c14d12b58977a03654f6e26aa018ab\", \"cronet_unittests\": \"22633395e6a163d05d4aa62fb047362fedfa175b\", \"crypto_unittests\": \"e71b5440451e96d1a080760834903ab2cdf2aba3\", \"dbus_unittests\": \"cc5a240c546f409db42f2e1ab6c0ed90e1594728\", \"device_unittests\": \"b36c4230c6d85bc51792df9d5b0ee10396ec49ad\", \"devtools_lint_check\": \"d10d9cdf648015a58a80a43f59828395e7c4a457\", \"devtools_type_check\": \"ef8b83dd660a03e1fb7c04222cff66305ffd56ec\", \"display_unittests\": \"4d0f5adfe87137e09da96f37ff6253ac8750b8f6\", \"events_unittests\": \"946fa9052ee9d134b30d94426783723e6095e211\", \"extensions_browsertests\": \"845dc0e2a2ee5f0cac51b17e8f0901fd0db2ac5a\", \"extensions_unittests\": \"25614886cf7a908b037ce90563715dd5437bad15\", \"filesystem_service_unittests\": \"be3849809dfeafd71aedbbfc9457cbb4d10a840e\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"240eff1bb96e18a836fa94b5217843a0d68be54a\", \"gfx_unittests\": \"6c2b74905683c3ae8a8bcf90b90aec5ed61d75be\", \"gin_unittests\": \"46737109f84d48651d1e3b7862198341aa9d1312\", \"google_apis_unittests\": \"c2082a19a8fe6779942d9ee729bf17435d4edfbe\", \"gpu_unittests\": \"deeb29da676dbd9bb2c0a6512c376a5e2822ee6e\", \"grit_python_unittests\": \"25dff9ef6327c596609d376409bc1d0e605b6d43\", \"gwp_asan_unittests\": \"35e599e9509bcbe1050f4e7472fb4672c5ca6320\", \"headless_browsertests\": \"abb193511c6744a87680c2797301f3214115c8be\", \"headless_unittests\": \"31026e383edd6197a1a6685cabe087135e474ff7\", \"interactive_ui_tests\": \"79148b3edabb8e5b069e5c61df2fedf03cfb16e4\", \"ipc_tests\": \"88b48f16c2bf5b639a9666870e15bc759627dbd7\", \"jingle_unittests\": \"c1c4d9d5535287bcd92e7e14e3415b7228384701\", \"latency_unittests\": \"b02a21dae29ccd83111b887462c30e82d38d63cb\", \"libjingle_xmpp_unittests\": \"e3d696176b3ce723737f9de04bba0cfffcc047d8\", \"media_blink_unittests\": \"61ed51b193722e356e36d7de74f324806693abdd\", \"media_service_unittests\": \"55f3b2c98f9835b0ccdbcd56b41af34b33493636\", \"media_unittests\": \"8005930189c9c54b65387f057b536ceffb774007\", \"message_center_unittests\": \"479763c1bc6c7a48366fc6cf5ff1588effe12c0e\", \"metrics_python_tests\": \"1ccb85dd0d69d06095342b3f87b0e87271f7c571\", \"midi_unittests\": \"dad4b5fcf0b9f179dec7c75c824eb69c65b2771a\", \"mojo_core_unittests\": \"23e0561e3ad88fbfaf6adca4e0ad42ce21cb51b6\", \"mojo_unittests\": \"c377c15b1d517bb28735fffc7a6ff54f350b25e4\", \"nacl_helper_nonsfi_unittests\": \"23014f3932194f12f7ace7a2843e4ee398068298\", \"nacl_loader_unittests\": \"ff426efd63bbc72fb4d6eda1e3f607b211f9ad30\", \"native_theme_unittests\": \"faf24bc9a18806616455f8c194faf968a34d81b9\", \"net_unittests\": \"613f16c25c75c2c958c8549f13fbf166be8d2b09\", \"pdf_unittests\": \"7855fca8c498aeb54f3920a35f397e7e67c355e1\", \"perfetto_unittests\": \"067a541c3d356bcc5569120e0f5cf83f9164b1cd\", \"ppapi_unittests\": \"13db18d36c3f6ae864451c7e5594b73ef4133ddf\", \"printing_unittests\": \"c595ddce06d2a01c8418d9321d4c14e07e9edff8\", \"remoting_unittests\": \"688845374870aab91892731b91a7e9b064b9ef98\", \"sandbox_linux_unittests\": \"97ee3a8b196a3d4f8fc513f17df53456921bf4ad\", \"service_manager_unittests\": \"77c5a38cb86240696e56bef5b643032042afbf62\", \"services_unittests\": \"efedc02e7b08411bd0d7396bfa3519bd89b8f700\", \"shell_dialogs_unittests\": \"99882d37bbc512935b687fb8fcaf14b6aef3cf4a\", \"skia_unittests\": \"61073cc38f4bc30666b88246bebcc68b75c5c405\", \"snapshot_unittests\": \"b6f0edaa2894a527760aba30a5885b0425703404\", \"sql_unittests\": \"ee073a4693b8215e1bc079c6324d333976f88b84\", \"storage_unittests\": \"fda1423534b164be47d266e09bd5f5ee031de3fd\", \"sync_integration_tests\": \"a5950e30a1292fa136c4a38a895ac85b192eb82a\", \"telemetry_gpu_unittests\": \"306a87e0236b981f27fd9cdb298cc30942cae6c4\", \"telemetry_perf_unittests\": \"67ee12f999c2ea5fef996c46c09157e5d526d738\", \"telemetry_unittests\": \"74507a67a23358bc58d64433f596f9008845dd45\", \"traffic_annotation_auditor_unittests\": \"6be25ef9f7416a422f741bea8c7d9e88e78d4588\", \"ui_base_unittests\": \"e9c7abf765db26f6db6772a7b6a293e62e7c2c90\", \"ui_touch_selection_unittests\": \"179c31b24e0a10839f124331316c8fa809029c2a\", \"unit_tests\": \"95e391186c43f2ff2944adb1ef25743c9a90debd\", \"url_unittests\": \"5f588bc9040197085d4aceea71cc49f7524ac5c6\", \"views_perftests\": \"14a67d1858e78f4ab07697b596f785cff329a6cc\", \"views_unittests\": \"cfe42386fc72ed01d0987be0de3b4a526b13969f\", \"viz_unittests\": \"49aac6c3d43e654e5523432389ace35152f62826\", \"vr_common_unittests\": \"23c6cdf4a5985bcc570c8b82e0fdc2c5143705f8\", \"vr_pixeltests\": \"f17421c705f6a0e9b38ff082e10d1a2453013a86\", \"webdriver_wpt_tests\": \"8ba07df6a40395be297aab89c5e0e90015d1590c\", \"weblayer_browsertests\": \"8f48e7383d4a3cb162065fc42ccf3a810d0466e4\", \"wm_unittests\": \"356435c9ee87c99c5098875b92e4763d6b42a230\", \"wtf_unittests\": \"2760eeacbcf0ee978bf483b9fba2108313c15a81\", \"xr_browser_tests\": \"4554fd6554f380da0b185ade8f3ff4d0228c25f5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0f0f2920b57dc7c027977ee87520a3ddbf7f87ddb2741f9160320f85fd7d4389_v2\", \"builder_3b404fa22a3c1a181985100df1a34c166b035b5f7265e772f51e56790f9dc011_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-99-tblm\"], \"image\": [\"chrome-xenial-19120800-09d8782d9a1\"], \"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\": [\"4730-f2fc813\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576608069651274",
"status": "COMPLETED",
"status_changed_ts": "1576610771706965",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166218",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6981e34204fb3a288ae94eeb373b1fed92cda1c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6981e34204fb3a288ae94eeb373b1fed92cda1c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059230707311329120",
"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/8893800644638613936/+/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:492df73e0a1cb910",
"user_agent:luci-scheduler"
],
"updated_ts": "1576610771710926",
"url": "https://ci.chromium.org/b/8893800644638613936",
"utcnow_ts": "1576610772153327"
}
}
[19:26:12.162] Invocation finished in 50m1.916492259s with status SUCCEEDED