[19:59:13.271] New invocation is queued and will start shortly
[19:59:14.391] Starting the invocation (attempt 1)
[19:59:14.447] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:59:14.447] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:59:14.448] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060584436748037152",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d661c0dd3ab2d9b38a693e74e56d4307b0290139\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060584436748037152",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d661c0dd3ab2d9b38a693e74e56d4307b0290139",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d661c0dd3ab2d9b38a693e74e56d4307b0290139",
"gitiles_ref:refs/heads/master"
]
}
[19:59:15.403] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575316754646959",
"id": "8895154374638395968",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d661c0dd3ab2d9b38a693e74e56d4307b0290139\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575316755177085",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165567",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d661c0dd3ab2d9b38a693e74e56d4307b0290139",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d661c0dd3ab2d9b38a693e74e56d4307b0290139",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060584436748037152",
"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/8895154374638395968/+/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": "1575316755177262",
"url": "https://ci.chromium.org/b/8895154374638395968",
"utcnow_ts": "1575316755389505"
}
}
[19:59:15.403] Task URL: https://ci.chromium.org/b/8895154374638395968
[19:59:15.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:2:0) after 1m0s
[20:00:15.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:2:0)
[20:00:15.517] Timer tick, asking Buildbucket for the build status
[20:00:16.345] Build 8895154374638395968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:16.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:3:0) after 1m0s
[20:01:16.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:3:0)
[20:01:16.458] Timer tick, asking Buildbucket for the build status
[20:01:17.876] Build 8895154374638395968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:17.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:4:0) after 1m0s
[20:02:18.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:4:0)
[20:02:18.591] Timer tick, asking Buildbucket for the build status
[20:02:18.892] Build 8895154374638395968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:18.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:5:0) after 1m0s
[20:03:19.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:5:0)
[20:03:19.234] Timer tick, asking Buildbucket for the build status
[20:03:19.918] Build 8895154374638395968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:19.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:6:0) after 1m0s
[20:04:10.012] Received PubSub notification, asking Buildbucket for the build status
[20:04:10.184] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:20.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:6:0)
[20:04:20.267] Timer tick, asking Buildbucket for the build status
[20:04:20.677] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:20.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:8:0) after 1m0s
[20:05:20.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:8:0)
[20:05:20.770] Timer tick, asking Buildbucket for the build status
[20:05:21.068] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:21.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:9:0) after 1m0s
[20:06:21.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:9:0)
[20:06:21.276] Timer tick, asking Buildbucket for the build status
[20:06:21.494] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:21.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:10:0) after 1m0s
[20:07:21.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:10:0)
[20:07:21.684] Timer tick, asking Buildbucket for the build status
[20:07:22.810] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:22.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:11:0) after 1m0s
[20:08:23.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:11:0)
[20:08:23.007] Timer tick, asking Buildbucket for the build status
[20:08:23.650] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:23.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:12:0) after 1m0s
[20:09:24.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:12:0)
[20:09:24.668] Timer tick, asking Buildbucket for the build status
[20:09:24.964] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:24.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:13:0) after 1m0s
[20:10:25.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:13:0)
[20:10:25.113] Timer tick, asking Buildbucket for the build status
[20:10:25.304] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:25.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:14:0) after 1m0s
[20:11:25.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:14:0)
[20:11:25.842] Timer tick, asking Buildbucket for the build status
[20:11:26.699] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:26.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:15:0) after 1m0s
[20:12:26.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:15:0)
[20:12:26.734] Timer tick, asking Buildbucket for the build status
[20:12:27.175] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:16:0) after 1m0s
[20:13:27.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:16:0)
[20:13:27.197] Timer tick, asking Buildbucket for the build status
[20:13:32.034] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:32.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:17:0) after 1m0s
[20:14:32.129] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:17:0)
[20:14:32.129] Timer tick, asking Buildbucket for the build status
[20:14:33.055] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:33.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:18:0) after 1m0s
[20:15:33.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:18:0)
[20:15:33.085] Timer tick, asking Buildbucket for the build status
[20:15:33.246] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:33.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:19:0) after 1m0s
[20:16:33.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:19:0)
[20:16:33.589] Timer tick, asking Buildbucket for the build status
[20:16:33.830] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:33.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:20:0) after 1m0s
[20:17:33.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:20:0)
[20:17:33.856] Timer tick, asking Buildbucket for the build status
[20:17:34.072] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:34.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:21:0) after 1m0s
[20:18:34.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:21:0)
[20:18:34.638] Timer tick, asking Buildbucket for the build status
[20:18:35.166] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:35.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:22:0) after 1m0s
[20:19:35.500] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:22:0)
[20:19:35.500] Timer tick, asking Buildbucket for the build status
[20:19:36.069] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:36.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:23:0) after 1m0s
[20:20:36.081] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:23:0)
[20:20:36.081] Timer tick, asking Buildbucket for the build status
[20:20:36.825] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:36.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:24:0) after 1m0s
[20:21:36.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:24:0)
[20:21:36.868] Timer tick, asking Buildbucket for the build status
[20:21:37.249] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:37.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:25:0) after 1m0s
[20:22:37.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:25:0)
[20:22:37.327] Timer tick, asking Buildbucket for the build status
[20:22:38.939] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:38.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:26:0) after 1m0s
[20:23:38.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:26:0)
[20:23:38.936] Timer tick, asking Buildbucket for the build status
[20:23:39.633] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:27:0) after 1m0s
[20:24:39.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:27:0)
[20:24:39.775] Timer tick, asking Buildbucket for the build status
[20:24:39.952] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:39.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:28:0) after 1m0s
[20:25:39.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:28:0)
[20:25:39.979] Timer tick, asking Buildbucket for the build status
[20:25:40.813] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:40.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:29:0) after 1m0s
[20:26:40.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:29:0)
[20:26:40.867] Timer tick, asking Buildbucket for the build status
[20:26:41.170] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:41.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:30:0) after 1m0s
[20:27:41.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:30:0)
[20:27:41.244] Timer tick, asking Buildbucket for the build status
[20:27:41.441] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:41.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:31:0) after 1m0s
[20:28:42.050] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:31:0)
[20:28:42.050] Timer tick, asking Buildbucket for the build status
[20:28:42.485] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:42.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:32:0) after 1m0s
[20:29:42.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:32:0)
[20:29:42.575] Timer tick, asking Buildbucket for the build status
[20:29:42.970] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:42.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:33:0) after 1m0s
[20:30:43.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:33:0)
[20:30:43.069] Timer tick, asking Buildbucket for the build status
[20:30:43.337] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:43.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:34:0) after 1m0s
[20:31:43.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:34:0)
[20:31:43.415] Timer tick, asking Buildbucket for the build status
[20:31:43.854] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:43.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:35:0) after 1m0s
[20:32:43.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:35:0)
[20:32:43.989] Timer tick, asking Buildbucket for the build status
[20:32:44.291] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:44.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:36:0) after 1m0s
[20:33:44.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:36:0)
[20:33:44.459] Timer tick, asking Buildbucket for the build status
[20:33:44.595] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:44.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:37:0) after 1m0s
[20:34:44.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:37:0)
[20:34:44.684] Timer tick, asking Buildbucket for the build status
[20:34:44.876] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:38:0) after 1m0s
[20:35:44.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:38:0)
[20:35:44.950] Timer tick, asking Buildbucket for the build status
[20:35:47.228] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:47.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:39:0) after 1m0s
[20:36:47.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:39:0)
[20:36:47.517] Timer tick, asking Buildbucket for the build status
[20:36:47.754] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:47.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:40:0) after 1m0s
[20:37:48.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:40:0)
[20:37:48.105] Timer tick, asking Buildbucket for the build status
[20:37:49.832] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:49.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:41:0) after 1m0s
[20:38:49.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:41:0)
[20:38:49.959] Timer tick, asking Buildbucket for the build status
[20:38:52.126] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:52.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:42:0) after 1m0s
[20:39:52.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:42:0)
[20:39:52.137] Timer tick, asking Buildbucket for the build status
[20:39:52.600] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:52.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:43:0) after 1m0s
[20:40:52.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:43:0)
[20:40:52.761] Timer tick, asking Buildbucket for the build status
[20:40:54.367] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:54.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:44:0) after 1m0s
[20:41:54.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:44:0)
[20:41:54.472] Timer tick, asking Buildbucket for the build status
[20:41:54.995] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:54.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:45:0) after 1m0s
[20:42:55.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:45:0)
[20:42:55.078] Timer tick, asking Buildbucket for the build status
[20:42:55.703] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:55.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:46:0) after 1m0s
[20:43:55.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:46:0)
[20:43:55.729] Timer tick, asking Buildbucket for the build status
[20:43:56.077] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:56.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:47:0) after 1m0s
[20:44:56.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:47:0)
[20:44:56.068] Timer tick, asking Buildbucket for the build status
[20:44:59.869] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:59.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:48:0) after 1m0s
[20:45:59.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:48:0)
[20:45:59.900] Timer tick, asking Buildbucket for the build status
[20:46:02.755] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:02.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:49:0) after 1m0s
[20:47:02.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:49:0)
[20:47:02.931] Timer tick, asking Buildbucket for the build status
[20:47:03.479] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:03.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:50:0) after 1m0s
[20:48:03.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:50:0)
[20:48:03.576] Timer tick, asking Buildbucket for the build status
[20:48:05.036] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:05.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:51:0) after 1m0s
[20:49:05.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:51:0)
[20:49:05.046] Timer tick, asking Buildbucket for the build status
[20:49:10.444] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:10.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:52:0) after 1m0s
[20:50:10.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:52:0)
[20:50:10.505] Timer tick, asking Buildbucket for the build status
[20:50:10.697] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:10.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:53:0) after 1m0s
[20:51:10.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:53:0)
[20:51:10.775] Timer tick, asking Buildbucket for the build status
[20:51:10.916] Build 8895154374638395968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:10.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060584436748037152:54:0) after 1m0s
[20:51:25.305] Received PubSub notification, asking Buildbucket for the build status
[20:51:25.601] Build 8895154374638395968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:51:25.601] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575319883902307",
"created_by": "project:chromium",
"created_ts": "1575316754646959",
"id": "8895154374638395968",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d661c0dd3ab2d9b38a693e74e56d4307b0290139\"}}",
"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-9-c2bm\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165567, \"got_angle_revision\": \"19f9f41481964be3a22e03a443eb37535a70e598\", \"got_dawn_revision\": \"969df2b3a21c126b2e0015ce2392c135f32a6a08\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d661c0dd3ab2d9b38a693e74e56d4307b0290139\", \"got_revision_cp\": \"refs/heads/master@{#720618}\", \"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\": \"d661c0dd3ab2d9b38a693e74e56d4307b0290139\", \"swarm_hashes_refs/heads/master(at){#720618}_without_patch\": {\"accessibility_unittests\": \"f503f8df5afa658164a178739a4eb7c5a57bf2ba\", \"angle_unittests\": \"c02be5c6b29ff07646d113564e3f16e6b953496b\", \"app_shell_unittests\": \"ff92dc5e981b6c896251668105e802a7f4d7c5d3\", \"aura_unittests\": \"884249dc1bdb7bef3f7c19c65bfd6a3c318f9de9\", \"base_unittests\": \"c592897acefc92a3eaf0a279bfd7d90167b9153f\", \"base_util_unittests\": \"9868864ede3a913e6072788dae1647cd9a17d4e2\", \"blink_common_unittests\": \"7debc48f3d5211b9f6a23a10a8527b56402e747a\", \"blink_fuzzer_unittests\": \"2764ce42cce741f8235f347ee5d021ee401ebcee\", \"blink_heap_unittests\": \"90e989839c61d24e36dcf88ad2a60e285656a53b\", \"blink_platform_unittests\": \"9cfab8194eebc15e445426cc4ec8f1d2d417e5df\", \"blink_python_tests\": \"6f52cd7fe7e73fd3df4eac75c3019ff49b1b222f\", \"blink_unittests\": \"ef063113801ec5a67237874619c818ec22e7141c\", \"blink_web_tests_exparchive\": \"e31afbb5f6ca8bd761d849293c372c8957f76122\", \"boringssl_crypto_tests\": \"028d08d197d41a960efafc2b5e27621db9678e26\", \"boringssl_ssl_tests\": \"c1b62ba504625184bd950b75b81cd938a09a3906\", \"browser_tests\": \"e175cd1158b136a8f6e7830c99e42ba49a2084c4\", \"cacheinvalidation_unittests\": \"6242b3a341a83f0d8e36ddc09ea9b7e01a3873bc\", \"capture_unittests\": \"b074d06b350f2b6b65ec3b8d3efb6f986dee0ef1\", \"cast_unittests\": \"5c9529bfe00cb44f64a016e4e6a53449686addcb\", \"cc_unittests\": \"88cd782d09b049c4358b5230328085fc465764f9\", \"chrome_app_unittests\": \"f7fdbd5f988073b454959295edb6dc72e2dfa8b8\", \"chromedriver_unittests\": \"ce63cfc3dcafb53fcdb737304c110dea90176195\", \"color_unittests\": \"e99ea9850e1f0545b20b92294d538307fd03644c\", \"components_browsertests\": \"8fb83342ac38b4cc9ac8719d15b41862289e3bb7\", \"components_unittests\": \"d38e4c2d3a7b4d13897e2f65ff3091d34c52eba9\", \"compositor_unittests\": \"397292988ff7ed1a15d1d5371022a9ea509c7b76\", \"content_browsertests\": \"13442abe6268b18759d9ad49310b153712e71e77\", \"content_shell_crash_test\": \"4c90c88a93f04d4a4b2840bfd3cd502afaedf27b\", \"content_unittests\": \"92736cd2b7be88a801d9ae748145f0565d6a4e2b\", \"crashpad_tests\": \"9bf7daf37f4dbe8550cd13871d79287dd360bc59\", \"cronet_tests\": \"eeb71dc689dbc64d147c7d80a0ed0f586ece9d85\", \"cronet_unittests\": \"d9b028f775485b857b7de7453fe98c4cc3c7d931\", \"crypto_unittests\": \"7e143c62b1d68250dfac5038d5d136e6eb3de2ac\", \"dbus_unittests\": \"254f507a92e5b4183a3c6e220061d4d01a3b907d\", \"device_unittests\": \"f8b4e72fd7da1ca7f81fd5e697cb064cf237eb46\", \"devtools_lint_check\": \"44c1734b03fc01a212f65b71ea0dedb87667eb65\", \"devtools_type_check\": \"b9c02a23a22c66eaf2d7ac2446048439c472da57\", \"display_unittests\": \"83d5a516fdf9a48e39b46a7f02f958c85395fd8e\", \"events_unittests\": \"b18786998f4236a87799e6af1f7405570cea9384\", \"extensions_browsertests\": \"ce0b383aff29c069ed41e1e0656106b2c1a4e88e\", \"extensions_unittests\": \"3462a208be45195a1796b1ddcd245d9301481037\", \"filesystem_service_unittests\": \"43c28261445830726a211a4862d2eba12719a2df\", \"flatbuffers_unittests\": \"c0f881c722359473554ea3438d382e7082a0e922\", \"gcm_unit_tests\": \"5b094ddc0bfa955338a74763a95b0e426373f1a0\", \"gfx_unittests\": \"ea8d1fdc703a05d35a6b963f456898a50d32c7ab\", \"gin_unittests\": \"51bf74433929a3fe9686606669fd77ec113ee488\", \"google_apis_unittests\": \"bf5e18bd97387a62f8061f459929c6fcc9cdb64c\", \"gpu_unittests\": \"889763d548cb2cceda7a0eabc412a3cc2773a4a9\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"0c50405724121b8c8c31ffb83915212df4d12180\", \"headless_browsertests\": \"866c21ea578ab8b65b971cb7a692e34ac1a80e26\", \"headless_unittests\": \"6770869f687a01b67c5c87400c16b931c1d67955\", \"interactive_ui_tests\": \"e65f0752d6829477436a93638832e9a3c4e617f9\", \"ipc_tests\": \"4791da2eb5e023177faf4721295ce63bb2d45480\", \"jingle_unittests\": \"4578fdfce718864b842a3062cf0e98b3b8879cbd\", \"latency_unittests\": \"4c563b16026686a3a4e0ff697686c926ad9985c4\", \"libjingle_xmpp_unittests\": \"ad40f7a811ceac4907c8059d654abcfeab3ce48b\", \"media_blink_unittests\": \"92fcbbfafdb61bebe5dfeb753fb6c6c4bdadd863\", \"media_service_unittests\": \"6fe4fdd3068e9229b89df7b168426898cb456a63\", \"media_unittests\": \"d07470d0cfb4b41f4656c65798ce65a5734a1a73\", \"message_center_unittests\": \"39ddb778939a71044ba6b39b112939f454adbedb\", \"metrics_python_tests\": \"8a6723c25f5268d058f45c76c0281b798de13ebe\", \"midi_unittests\": \"3568ca5d68f9282ef94e8e9ef830917068c67da1\", \"mojo_core_unittests\": \"fbf2788f807c836b268fc5b1b291bdd040bf9eab\", \"mojo_unittests\": \"4f8cd8b993d7cc04e9d6597abb89e791e40354e9\", \"nacl_helper_nonsfi_unittests\": \"5e2fab327f4e26c28dbb7f3f3c822f3cd3b2d084\", \"nacl_loader_unittests\": \"695f0adf2a5a7c5b7e8e2545b5dded307784da31\", \"native_theme_unittests\": \"b2b11c70348162e70a9eb80d1e44dc1f03085cb9\", \"net_unittests\": \"44ae1b006bfdfa7199414128d5483a9ffe816636\", \"pdf_unittests\": \"ccdf694b55e5a514f13982ce490060be1ca8e6e7\", \"perfetto_unittests\": \"0fd074230453afa975c33e223833ccdee20f2fe9\", \"ppapi_unittests\": \"9dd74634c8122c727815c2f5f903fda892270bb1\", \"printing_unittests\": \"12e36e4b52d48320bc97d589bc6cae9084153dc7\", \"remoting_unittests\": \"dcaf93d1c7c2eb5ba078ecb100c445998f3f04b3\", \"sandbox_linux_unittests\": \"983a36377b08d91624c1d4715d03823a596c6c6b\", \"service_manager_unittests\": \"106b43748cef7513755ada848db22d741fd23103\", \"services_unittests\": \"c4ed9fbc6fbae61a0f579af4fc505685df5dc916\", \"shell_dialogs_unittests\": \"90aabf98d63d9819ffa049dba85eedde223111c6\", \"skia_unittests\": \"9a1d1f82149ff7e2d0d1ea3203e9d83aa7f19274\", \"snapshot_unittests\": \"56ed2f79d5254679ec6dc9cd0323105fc43622ac\", \"sql_unittests\": \"e4369f0f3c921e7cf12890c9ea5642118ab060c4\", \"storage_unittests\": \"f8b63988315f2ada87462f9be42dba92fda75426\", \"sync_integration_tests\": \"5ea50806d75e0c08456e600e81ae9aa7d56007a7\", \"telemetry_gpu_unittests\": \"90cd5966ec0164f8bf29ddbb0d7034a832154c76\", \"telemetry_perf_unittests\": \"7d1d8423399ba2ba6eced03eff996f51009213a6\", \"telemetry_unittests\": \"392e05d84ceede7df47159d1769c02451a4ffebd\", \"traffic_annotation_auditor_unittests\": \"b4dc28adcd71ca88cb99078b841402b242ded60b\", \"ui_base_unittests\": \"ed24938ef08cdcfe832dd0d79f53f37f328f6153\", \"ui_touch_selection_unittests\": \"17a06f44855876abecc58e09ba48b17b5934e25f\", \"unit_tests\": \"a4b470740b1b20bcf3859e175da6b036713fc949\", \"url_unittests\": \"197fc123fdb4ccde7e880279645482f15e729a32\", \"views_perftests\": \"497feab53c8b43537ce3c825ccc588661dd85c80\", \"views_unittests\": \"34e5ee4fd47b28b3dfb9c9ed47b35e0cfeeba5d7\", \"viz_unittests\": \"26942482d384161e9ffe4e28d69973a7e205bde9\", \"vr_common_unittests\": \"bc5c4333dd33b795d3027f753fc4bbf5a1b10991\", \"vr_pixeltests\": \"186f26bc0f3bd9d518ad0978950f7f46ed3e85ff\", \"webdriver_wpt_tests\": \"44f8d169f47c7d666059f5a330bcc3cb247b7016\", \"weblayer_browsertests\": \"99beab281974a505e1bfb805ba5c85c0d4bf50b8\", \"wm_unittests\": \"6bf213e9166c0f053f97747e02e5ecfbf40f2b08\", \"wtf_unittests\": \"4a06f30a5637d611527cd5b2d0f2a52a952190db\", \"xr_browser_tests\": \"276a27b9fb6301752d1c935f6182bcf7a2a3f618\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0b04f8cc6159258d804e25106396716d7d6fee48172e72693cbc82316c10e569_v2\", \"builder_65fafd0c860c8cf0043a2ec0f6482d6e089dd429d22310040aa34c8b96106827_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-9-c2bm\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575317048056952",
"status": "COMPLETED",
"status_changed_ts": "1575319884630065",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165567",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d661c0dd3ab2d9b38a693e74e56d4307b0290139",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d661c0dd3ab2d9b38a693e74e56d4307b0290139",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060584436748037152",
"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/8895154374638395968/+/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:48e103f187198010",
"user_agent:luci-scheduler"
],
"updated_ts": "1575319884661357",
"url": "https://ci.chromium.org/b/8895154374638395968",
"utcnow_ts": "1575319885585308"
}
}
[20:51:25.601] Invocation finished in 52m12.349808538s with status SUCCEEDED