[20:51:29.141] New invocation is queued and will start shortly
[20:51:30.245] Starting the invocation (attempt 1)
[20:51:30.335] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:51:30.335] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:51:30.336] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060581148549333872",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"af6d187fb066d90958ea7499d690c6e06a7fbe9d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060581148549333872",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/af6d187fb066d90958ea7499d690c6e06a7fbe9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6d187fb066d90958ea7499d690c6e06a7fbe9d",
"gitiles_ref:refs/heads/master"
]
}
[20:51:32.725] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575319891518277",
"id": "8895151085389563328",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6d187fb066d90958ea7499d690c6e06a7fbe9d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575319892439685",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165568",
"builder:Linux Builder (dbg)",
"buildset:commit/git/af6d187fb066d90958ea7499d690c6e06a7fbe9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6d187fb066d90958ea7499d690c6e06a7fbe9d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060581148549333872",
"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/8895151085389563328/+/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": "1575319892439803",
"url": "https://ci.chromium.org/b/8895151085389563328",
"utcnow_ts": "1575319892707310"
}
}
[20:51:32.725] Task URL: https://ci.chromium.org/b/8895151085389563328
[20:51:32.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:2:0) after 1m0s
[20:52:32.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:2:0)
[20:52:32.782] Timer tick, asking Buildbucket for the build status
[20:52:33.008] Build 8895151085389563328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:33.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:3:0) after 1m0s
[20:53:33.070] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:3:0)
[20:53:33.070] Timer tick, asking Buildbucket for the build status
[20:53:33.269] Build 8895151085389563328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:33.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:4:0) after 1m0s
[20:54:33.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:4:0)
[20:54:33.362] Timer tick, asking Buildbucket for the build status
[20:54:33.861] Build 8895151085389563328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:5:0) after 1m0s
[20:55:33.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:5:0)
[20:55:33.926] Timer tick, asking Buildbucket for the build status
[20:55:34.454] Build 8895151085389563328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:34.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:6:0) after 1m0s
[20:55:47.842] Received PubSub notification, asking Buildbucket for the build status
[20:55:48.072] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:34.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:6:0)
[20:56:34.476] Timer tick, asking Buildbucket for the build status
[20:56:34.760] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:34.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:8:0) after 1m0s
[20:57:34.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:8:0)
[20:57:34.800] Timer tick, asking Buildbucket for the build status
[20:57:34.989] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:34.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:9:0) after 1m0s
[20:58:35.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:9:0)
[20:58:35.036] Timer tick, asking Buildbucket for the build status
[20:58:35.441] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:35.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:10:0) after 1m0s
[20:59:35.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:10:0)
[20:59:35.472] Timer tick, asking Buildbucket for the build status
[20:59:35.701] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:35.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:11:0) after 1m0s
[21:00:36.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:11:0)
[21:00:36.012] Timer tick, asking Buildbucket for the build status
[21:00:36.227] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:36.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:12:0) after 1m0s
[21:01:36.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:12:0)
[21:01:36.289] Timer tick, asking Buildbucket for the build status
[21:01:36.477] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:36.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:13:0) after 1m0s
[21:02:36.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:13:0)
[21:02:36.749] Timer tick, asking Buildbucket for the build status
[21:02:39.060] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:39.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:14:0) after 1m0s
[21:03:39.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:14:0)
[21:03:39.393] Timer tick, asking Buildbucket for the build status
[21:03:39.709] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:39.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:15:0) after 1m0s
[21:04:39.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:15:0)
[21:04:39.994] Timer tick, asking Buildbucket for the build status
[21:04:40.516] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:16:0) after 1m0s
[21:05:40.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:16:0)
[21:05:40.586] Timer tick, asking Buildbucket for the build status
[21:05:41.530] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:41.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:17:0) after 1m0s
[21:06:41.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:17:0)
[21:06:41.574] Timer tick, asking Buildbucket for the build status
[21:06:45.446] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:45.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:18:0) after 1m0s
[21:07:45.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:18:0)
[21:07:45.511] Timer tick, asking Buildbucket for the build status
[21:07:46.290] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:46.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:19:0) after 1m0s
[21:08:46.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:19:0)
[21:08:46.366] Timer tick, asking Buildbucket for the build status
[21:08:47.000] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:47.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:20:0) after 1m0s
[21:09:47.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:20:0)
[21:09:47.112] Timer tick, asking Buildbucket for the build status
[21:09:47.287] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:47.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:21:0) after 1m0s
[21:10:47.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:21:0)
[21:10:47.611] Timer tick, asking Buildbucket for the build status
[21:10:47.773] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:47.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:22:0) after 1m0s
[21:11:47.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:22:0)
[21:11:47.909] Timer tick, asking Buildbucket for the build status
[21:11:48.492] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:48.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:23:0) after 1m0s
[21:12:48.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:23:0)
[21:12:48.882] Timer tick, asking Buildbucket for the build status
[21:12:49.450] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:49.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:24:0) after 1m0s
[21:13:49.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:24:0)
[21:13:49.939] Timer tick, asking Buildbucket for the build status
[21:13:50.190] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:50.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:25:0) after 1m0s
[21:14:50.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:25:0)
[21:14:50.353] Timer tick, asking Buildbucket for the build status
[21:14:50.586] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:50.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:26:0) after 1m0s
[21:15:50.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:26:0)
[21:15:50.719] Timer tick, asking Buildbucket for the build status
[21:15:50.861] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:50.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:27:0) after 1m0s
[21:16:51.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:27:0)
[21:16:51.065] Timer tick, asking Buildbucket for the build status
[21:16:53.747] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:53.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:28:0) after 1m0s
[21:17:54.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:28:0)
[21:17:54.215] Timer tick, asking Buildbucket for the build status
[21:17:54.420] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:54.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:29:0) after 1m0s
[21:18:54.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:29:0)
[21:18:54.569] Timer tick, asking Buildbucket for the build status
[21:18:54.798] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:54.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:30:0) after 1m0s
[21:19:55.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:30:0)
[21:19:55.137] Timer tick, asking Buildbucket for the build status
[21:19:55.493] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:55.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:31:0) after 1m0s
[21:20:55.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:31:0)
[21:20:55.719] Timer tick, asking Buildbucket for the build status
[21:20:55.949] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:55.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:32:0) after 1m0s
[21:21:56.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:32:0)
[21:21:56.387] Timer tick, asking Buildbucket for the build status
[21:21:56.979] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:56.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:33:0) after 1m0s
[21:22:56.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:33:0)
[21:22:56.989] Timer tick, asking Buildbucket for the build status
[21:22:57.203] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:57.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:34:0) after 1m0s
[21:23:57.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:34:0)
[21:23:57.341] Timer tick, asking Buildbucket for the build status
[21:23:57.947] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:57.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:35:0) after 1m0s
[21:24:57.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:35:0)
[21:24:57.979] Timer tick, asking Buildbucket for the build status
[21:24:58.392] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:58.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:36:0) after 1m0s
[21:25:58.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:36:0)
[21:25:58.544] Timer tick, asking Buildbucket for the build status
[21:25:59.182] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:59.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:37:0) after 1m0s
[21:26:59.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:37:0)
[21:26:59.237] Timer tick, asking Buildbucket for the build status
[21:27:01.199] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:01.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:38:0) after 1m0s
[21:28:01.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:38:0)
[21:28:01.372] Timer tick, asking Buildbucket for the build status
[21:28:01.540] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:01.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:39:0) after 1m0s
[21:29:01.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:39:0)
[21:29:01.669] Timer tick, asking Buildbucket for the build status
[21:29:03.615] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:03.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:40:0) after 1m0s
[21:30:03.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:40:0)
[21:30:03.693] Timer tick, asking Buildbucket for the build status
[21:30:06.182] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:41:0) after 1m0s
[21:31:06.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:41:0)
[21:31:06.350] Timer tick, asking Buildbucket for the build status
[21:31:06.869] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:06.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:42:0) after 1m0s
[21:32:06.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:42:0)
[21:32:06.979] Timer tick, asking Buildbucket for the build status
[21:32:07.575] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:07.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:43:0) after 1m0s
[21:33:07.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:43:0)
[21:33:07.720] Timer tick, asking Buildbucket for the build status
[21:33:10.978] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:10.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:44:0) after 1m0s
[21:34:11.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:44:0)
[21:34:11.092] Timer tick, asking Buildbucket for the build status
[21:34:11.346] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:11.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:45:0) after 1m0s
[21:35:11.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:45:0)
[21:35:11.400] Timer tick, asking Buildbucket for the build status
[21:35:13.264] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:13.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:46:0) after 1m0s
[21:36:13.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:46:0)
[21:36:13.305] Timer tick, asking Buildbucket for the build status
[21:36:13.510] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:13.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:47:0) after 1m0s
[21:37:13.683] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:47:0)
[21:37:13.683] Timer tick, asking Buildbucket for the build status
[21:37:14.005] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:14.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:48:0) after 1m0s
[21:38:14.060] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:48:0)
[21:38:14.061] Timer tick, asking Buildbucket for the build status
[21:38:14.601] Build 8895151085389563328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:14.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060581148549333872:49:0) after 1m0s
[21:38:30.832] Received PubSub notification, asking Buildbucket for the build status
[21:38:31.383] Build 8895151085389563328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:38:31.383] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575322710042447",
"created_by": "project:chromium",
"created_ts": "1575319891518277",
"id": "8895151085389563328",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6d187fb066d90958ea7499d690c6e06a7fbe9d\"}}",
"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-110-rl1d\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165568, \"got_angle_revision\": \"19f9f41481964be3a22e03a443eb37535a70e598\", \"got_dawn_revision\": \"969df2b3a21c126b2e0015ce2392c135f32a6a08\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"af6d187fb066d90958ea7499d690c6e06a7fbe9d\", \"got_revision_cp\": \"refs/heads/master@{#720643}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b64fbfec4dcd3f81c776198641b1fc71ac8d64a4\", \"got_v8_revision\": \"be74b8b6917660e3de1e25875f0a938bedb103cc\", \"got_v8_revision_cp\": \"refs/heads/8.0.424@{#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\": \"af6d187fb066d90958ea7499d690c6e06a7fbe9d\", \"swarm_hashes_refs/heads/master(at){#720643}_without_patch\": {\"accessibility_unittests\": \"124d235b4de59b41aae0b06d83ccd413e7717ef8\", \"angle_unittests\": \"c02be5c6b29ff07646d113564e3f16e6b953496b\", \"app_shell_unittests\": \"5284503c7a32f33dfe63ca81d6dd32431380a12f\", \"aura_unittests\": \"931511c8d2d7dc14a7536ea321f53be71ebac4cc\", \"base_unittests\": \"c592897acefc92a3eaf0a279bfd7d90167b9153f\", \"base_util_unittests\": \"9868864ede3a913e6072788dae1647cd9a17d4e2\", \"blink_common_unittests\": \"a3fd7c42a335a3e620d5397a33302455bd52f1f1\", \"blink_fuzzer_unittests\": \"edb49859539eb43388152102ef191b49af9030b7\", \"blink_heap_unittests\": \"b2eb16c7c417f02576db93012fce1d70bc4c7c34\", \"blink_platform_unittests\": \"f15037fd7f62c0cdd239f088a1c4d45bf82d9d6d\", \"blink_python_tests\": \"6f52cd7fe7e73fd3df4eac75c3019ff49b1b222f\", \"blink_unittests\": \"8feb0f0d35c9ddc3a94bceca93523abbca0bece0\", \"blink_web_tests_exparchive\": \"af3461038fe3dcfdcb0513cb40905a6ab1abd0e9\", \"boringssl_crypto_tests\": \"028d08d197d41a960efafc2b5e27621db9678e26\", \"boringssl_ssl_tests\": \"c1b62ba504625184bd950b75b81cd938a09a3906\", \"browser_tests\": \"73156355b9aebaceadb8c74af9cd3d89547ba96b\", \"cacheinvalidation_unittests\": \"6242b3a341a83f0d8e36ddc09ea9b7e01a3873bc\", \"capture_unittests\": \"2ca16944629b44f3547b4a9c6cda39c11aac5ef5\", \"cast_unittests\": \"de805103f727ad5a19f95a4102bec74f10f96b29\", \"cc_unittests\": \"9a3ba05a6acbe2538a0bfdc78675bb2bf3430faf\", \"chrome_app_unittests\": \"82f39d36f8589d515c983eb6f5de141a8d4c8c34\", \"chromedriver_unittests\": \"d904368515a9ff5bfa3f341722ae44d6cc40e103\", \"color_unittests\": \"e99ea9850e1f0545b20b92294d538307fd03644c\", \"components_browsertests\": \"ffd5e03bd0aac9d4e27592806afae00bf50b6e82\", \"components_unittests\": \"84c27b7e6b26230d658da3d19476189092350fe9\", \"compositor_unittests\": \"af55fecd00afaf42f7d86e8c8f07d7968d25a936\", \"content_browsertests\": \"8618e6484466f0e226965d5ed7dc964f77712cd2\", \"content_shell_crash_test\": \"e6ed971bf7831e40849338e649480a4562425c88\", \"content_unittests\": \"1d405074d98060cc70f5c57d13efb865b29a9347\", \"crashpad_tests\": \"9bf7daf37f4dbe8550cd13871d79287dd360bc59\", \"cronet_tests\": \"370a2e55044f8235b9162d50a3325600ad30fd44\", \"cronet_unittests\": \"545081ae8d05ae3e3852b47938fbdffeebe5150f\", \"crypto_unittests\": \"7e143c62b1d68250dfac5038d5d136e6eb3de2ac\", \"dbus_unittests\": \"254f507a92e5b4183a3c6e220061d4d01a3b907d\", \"device_unittests\": \"d245d33cb38482c11e8ef9820d138f5bf494da2d\", \"devtools_lint_check\": \"44c1734b03fc01a212f65b71ea0dedb87667eb65\", \"devtools_type_check\": \"b9c02a23a22c66eaf2d7ac2446048439c472da57\", \"display_unittests\": \"76e2caf685eed1bdd851a038f1f3c801f443487a\", \"events_unittests\": \"4cdfbbbca37aa06c4fb1f74267d581371ec90a3a\", \"extensions_browsertests\": \"efa308ff64876cb9df3ed5c9c50cc59540dca4aa\", \"extensions_unittests\": \"e04251bd662030d9e872ac44c71814909076d0de\", \"filesystem_service_unittests\": \"43c28261445830726a211a4862d2eba12719a2df\", \"flatbuffers_unittests\": \"c0f881c722359473554ea3438d382e7082a0e922\", \"gcm_unit_tests\": \"c5263badb90092aba5aa4ea418fd8afab0373d29\", \"gfx_unittests\": \"310b6eb1e55fc0c7ef410003027aeb5a3d9650be\", \"gin_unittests\": \"1adcdbcb15f10928a6adefbba759b57773133ae5\", \"google_apis_unittests\": \"96f1a2f9f32936d8c19282a5c540599615c06467\", \"gpu_unittests\": \"912f78797138cf4091d2648ca617f4733c26594e\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"0c50405724121b8c8c31ffb83915212df4d12180\", \"headless_browsertests\": \"88093514b101214ad3ef6e5c8abdbfdd52d8d699\", \"headless_unittests\": \"d9b079b92f5110d8195307ea0e38e8049fa23998\", \"interactive_ui_tests\": \"f8d0ecf9376c13d468117474623a22504f4fa283\", \"ipc_tests\": \"4791da2eb5e023177faf4721295ce63bb2d45480\", \"jingle_unittests\": \"9097e4d5217203599a909efff03916750005e7a9\", \"latency_unittests\": \"4c563b16026686a3a4e0ff697686c926ad9985c4\", \"libjingle_xmpp_unittests\": \"ca0b2864552e68c1cb0bd5e3b89f93e2d129e927\", \"media_blink_unittests\": \"5dd70114d748597b04b627f218fd3f29df023bfb\", \"media_service_unittests\": \"bfc6719fe70b5cc58ca89ee8df9c3a92f9dc6a32\", \"media_unittests\": \"d57bda0839bc160cad607d7743771358e9b379a5\", \"message_center_unittests\": \"e3d4ef9ee8bf63a7f79c91d7933e029c281cebae\", \"metrics_python_tests\": \"8a6723c25f5268d058f45c76c0281b798de13ebe\", \"midi_unittests\": \"3568ca5d68f9282ef94e8e9ef830917068c67da1\", \"mojo_core_unittests\": \"fbf2788f807c836b268fc5b1b291bdd040bf9eab\", \"mojo_unittests\": \"00f6cda3fdefabbcf6942d4aef2a6e0ecb131c8f\", \"nacl_helper_nonsfi_unittests\": \"5e2fab327f4e26c28dbb7f3f3c822f3cd3b2d084\", \"nacl_loader_unittests\": \"e6f84011895ade4e4be035bffed201717841e12f\", \"native_theme_unittests\": \"27ec7ce99588aadd858550bf124d520b4c784cd1\", \"net_unittests\": \"cb48ef3deb287e02b8366219e81f76356b41ed93\", \"pdf_unittests\": \"cf51e6504c16ae4cb01e8c6a0f7d06551669fa5f\", \"perfetto_unittests\": \"0fd074230453afa975c33e223833ccdee20f2fe9\", \"ppapi_unittests\": \"2d8e77a12cb9a63cb13a4036af97969399b73b90\", \"printing_unittests\": \"e11775d10b05013414eb40db92a46a81fbd6bc41\", \"remoting_unittests\": \"aa50429fefc08e6029c5762e425346d1d4eab9d6\", \"sandbox_linux_unittests\": \"983a36377b08d91624c1d4715d03823a596c6c6b\", \"service_manager_unittests\": \"766f8ae8ceebbc2d832415ab442fdad341a951ea\", \"services_unittests\": \"3755c29b5c13196e8bde5116e205e7835ca0596c\", \"shell_dialogs_unittests\": \"329b81a8886bb379581714e3c9f5651f63fcee10\", \"skia_unittests\": \"7ddc29da039dba249ef8f29314846461df38ef6f\", \"snapshot_unittests\": \"d78b9ac9a46fc2a7411194d90965c7c0c546f1cf\", \"sql_unittests\": \"e4369f0f3c921e7cf12890c9ea5642118ab060c4\", \"storage_unittests\": \"195bf80d7001d96f054f8fad6dc1ba4ef593d2bd\", \"sync_integration_tests\": \"fdf1c28055925cebf45389cd974fb0618b307ae0\", \"telemetry_gpu_unittests\": \"28d52d7bfdf992b2d07e3cc4796c62eb71821b26\", \"telemetry_perf_unittests\": \"60ed114f473879b5ca5b43399c40024064ba4f4a\", \"telemetry_unittests\": \"db638a57407c61be3af92052a69480b826ec7fb4\", \"traffic_annotation_auditor_unittests\": \"b4dc28adcd71ca88cb99078b841402b242ded60b\", \"ui_base_unittests\": \"8ff341e485632ce61071f5f412ba7d09fd7cb424\", \"ui_touch_selection_unittests\": \"afdbef123a990a329c951de010b1d98942250683\", \"unit_tests\": \"02617c43c7837d6a297b4a5d4d8e9916033fdd3c\", \"url_unittests\": \"197fc123fdb4ccde7e880279645482f15e729a32\", \"views_perftests\": \"0611e6c3383f9fa7fec67c04e0c8141c9f223fbf\", \"views_unittests\": \"36d27b29706938334d7e4cfa4c5c0d3bd2e2459a\", \"viz_unittests\": \"344cce04da31472246a43ed9c534c20bd7a8e3b9\", \"vr_common_unittests\": \"3dcfb969c96ada009393666c37b882c58c5a9003\", \"vr_pixeltests\": \"569efa89d700cd3f97482309068de3c90752c645\", \"webdriver_wpt_tests\": \"14fbe100e30bbdeef05245f3e94137dedb13ebb1\", \"weblayer_browsertests\": \"a60774ab1532aa2612df6c103b1650e0dca37d61\", \"wm_unittests\": \"ae30dc19ad483f1bd487b367416ff2836e7a9d27\", \"wtf_unittests\": \"4a06f30a5637d611527cd5b2d0f2a52a952190db\", \"xr_browser_tests\": \"11c6e5344465517541b43dead64bd8924e98dc2f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_479a9ab4e006ab9f281a30e38952e2c387e86fd61a54f6cd68389780c770d389_v2\", \"builder_c38832248eaa59248ebe0e5d5ae62a6bc955f53f6a99a9c0e5cded93d679f9bc_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-110-rl1d\"], \"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\": [\"4679-6acb960\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575320146953504",
"status": "COMPLETED",
"status_changed_ts": "1575322710363035",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165568",
"builder:Linux Builder (dbg)",
"buildset:commit/git/af6d187fb066d90958ea7499d690c6e06a7fbe9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6d187fb066d90958ea7499d690c6e06a7fbe9d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060581148549333872",
"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/8895151085389563328/+/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:48e133c6b4432510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575322710374780",
"url": "https://ci.chromium.org/b/8895151085389563328",
"utcnow_ts": "1575322711374371"
}
}
[21:38:31.383] Invocation finished in 47m2.262411824s with status SUCCEEDED