[21:52:54.833] New invocation is queued and will start shortly
[21:52:56.103] Starting the invocation (attempt 1)
[21:52:56.180] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:52:56.180] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:52:56.180] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056772211241880032",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bfd8bf55775d00438efa2fef33587ad4eb723f17\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056772211241880032",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/bfd8bf55775d00438efa2fef33587ad4eb723f17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bfd8bf55775d00438efa2fef33587ad4eb723f17",
"gitiles_ref:refs/heads/master"
]
}
[21:52:57.289] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578952376502026",
"id": "8891342148815527936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bfd8bf55775d00438efa2fef33587ad4eb723f17\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578952377128917",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167337",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bfd8bf55775d00438efa2fef33587ad4eb723f17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bfd8bf55775d00438efa2fef33587ad4eb723f17",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056772211241880032",
"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/8891342148815527936/+/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": "1578952377129082",
"url": "https://ci.chromium.org/b/8891342148815527936",
"utcnow_ts": "1578952377280853"
}
}
[21:52:57.289] Task URL: https://ci.chromium.org/b/8891342148815527936
[21:52:57.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:2:0) after 1m0s
[21:53:57.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:2:0)
[21:53:57.455] Timer tick, asking Buildbucket for the build status
[21:53:57.903] Build 8891342148815527936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:53:57.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:3:0) after 1m0s
[21:54:58.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:3:0)
[21:54:58.207] Timer tick, asking Buildbucket for the build status
[21:54:58.629] Build 8891342148815527936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:54:58.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:4:0) after 1m0s
[21:55:58.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:4:0)
[21:55:58.981] Timer tick, asking Buildbucket for the build status
[21:55:59.351] Build 8891342148815527936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:59.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:5:0) after 1m0s
[21:56:59.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:5:0)
[21:56:59.674] Timer tick, asking Buildbucket for the build status
[21:56:59.965] Build 8891342148815527936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:59.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:6:0) after 1m0s
[21:58:00.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:6:0)
[21:58:00.152] Timer tick, asking Buildbucket for the build status
[21:58:01.021] Build 8891342148815527936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:01.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:7:0) after 1m0s
[21:59:01.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:7:0)
[21:59:01.056] Timer tick, asking Buildbucket for the build status
[21:59:01.406] Build 8891342148815527936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:01.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:8:0) after 1m0s
[21:59:05.631] Received PubSub notification, asking Buildbucket for the build status
[21:59:06.163] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:01.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:8:0)
[22:00:01.712] Timer tick, asking Buildbucket for the build status
[22:00:02.644] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:02.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:10:0) after 1m0s
[22:01:02.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:10:0)
[22:01:02.911] Timer tick, asking Buildbucket for the build status
[22:01:07.855] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:07.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:11:0) after 1m0s
[22:02:08.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:11:0)
[22:02:08.224] Timer tick, asking Buildbucket for the build status
[22:02:08.685] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:08.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:12:0) after 1m0s
[22:03:10.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:12:0)
[22:03:10.062] Timer tick, asking Buildbucket for the build status
[22:03:10.712] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:10.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:13:0) after 1m0s
[22:04:11.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:13:0)
[22:04:11.113] Timer tick, asking Buildbucket for the build status
[22:04:12.239] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:12.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:14:0) after 1m0s
[22:05:13.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:14:0)
[22:05:13.074] Timer tick, asking Buildbucket for the build status
[22:05:13.247] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:13.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:15:0) after 1m0s
[22:06:13.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:15:0)
[22:06:13.829] Timer tick, asking Buildbucket for the build status
[22:06:14.920] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:14.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:16:0) after 1m0s
[22:07:15.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:16:0)
[22:07:15.069] Timer tick, asking Buildbucket for the build status
[22:07:15.390] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:15.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:17:0) after 1m0s
[22:08:15.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:17:0)
[22:08:15.487] Timer tick, asking Buildbucket for the build status
[22:08:15.773] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:15.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:18:0) after 1m0s
[22:09:16.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:18:0)
[22:09:16.328] Timer tick, asking Buildbucket for the build status
[22:09:16.554] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:16.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:19:0) after 1m0s
[22:10:16.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:19:0)
[22:10:16.900] Timer tick, asking Buildbucket for the build status
[22:10:17.206] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:17.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:20:0) after 1m0s
[22:11:17.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:20:0)
[22:11:17.607] Timer tick, asking Buildbucket for the build status
[22:11:17.794] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:17.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:21:0) after 1m0s
[22:12:18.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:21:0)
[22:12:18.316] Timer tick, asking Buildbucket for the build status
[22:12:18.562] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:18.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:22:0) after 1m0s
[22:13:18.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:22:0)
[22:13:18.913] Timer tick, asking Buildbucket for the build status
[22:13:19.147] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:19.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:23:0) after 1m0s
[22:14:19.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:23:0)
[22:14:19.233] Timer tick, asking Buildbucket for the build status
[22:14:19.471] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:19.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:24:0) after 1m0s
[22:15:19.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:24:0)
[22:15:19.677] Timer tick, asking Buildbucket for the build status
[22:15:20.470] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:20.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:25:0) after 1m0s
[22:16:20.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:25:0)
[22:16:20.562] Timer tick, asking Buildbucket for the build status
[22:16:20.937] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:20.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:26:0) after 1m0s
[22:17:21.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:26:0)
[22:17:21.107] Timer tick, asking Buildbucket for the build status
[22:17:21.926] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:21.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:27:0) after 1m0s
[22:18:21.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:27:0)
[22:18:21.948] Timer tick, asking Buildbucket for the build status
[22:18:22.170] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:22.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:28:0) after 1m0s
[22:19:22.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:28:0)
[22:19:22.205] Timer tick, asking Buildbucket for the build status
[22:19:22.605] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:22.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:29:0) after 1m0s
[22:20:22.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:29:0)
[22:20:22.652] Timer tick, asking Buildbucket for the build status
[22:20:22.919] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:22.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:30:0) after 1m0s
[22:21:23.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:30:0)
[22:21:23.003] Timer tick, asking Buildbucket for the build status
[22:21:25.355] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:25.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:31:0) after 1m0s
[22:22:25.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:31:0)
[22:22:25.442] Timer tick, asking Buildbucket for the build status
[22:22:25.550] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:25.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:32:0) after 1m0s
[22:23:25.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:32:0)
[22:23:25.740] Timer tick, asking Buildbucket for the build status
[22:23:26.002] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:26.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:33:0) after 1m0s
[22:24:26.079] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:33:0)
[22:24:26.079] Timer tick, asking Buildbucket for the build status
[22:24:27.544] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:27.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:34:0) after 1m0s
[22:25:27.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:34:0)
[22:25:27.638] Timer tick, asking Buildbucket for the build status
[22:25:27.831] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:35:0) after 1m0s
[22:26:27.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:35:0)
[22:26:27.935] Timer tick, asking Buildbucket for the build status
[22:26:28.207] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:28.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:36:0) after 1m0s
[22:27:28.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:36:0)
[22:27:28.210] Timer tick, asking Buildbucket for the build status
[22:27:28.405] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:28.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:37:0) after 1m0s
[22:28:28.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:37:0)
[22:28:28.430] Timer tick, asking Buildbucket for the build status
[22:28:28.574] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:28.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:38:0) after 1m0s
[22:29:28.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:38:0)
[22:29:28.802] Timer tick, asking Buildbucket for the build status
[22:29:29.108] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:29.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:39:0) after 1m0s
[22:30:29.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:39:0)
[22:30:29.272] Timer tick, asking Buildbucket for the build status
[22:30:29.564] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:29.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:40:0) after 1m0s
[22:31:29.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:40:0)
[22:31:29.932] Timer tick, asking Buildbucket for the build status
[22:31:31.228] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:31.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:41:0) after 1m0s
[22:32:31.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:41:0)
[22:32:31.286] Timer tick, asking Buildbucket for the build status
[22:32:31.497] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:31.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:42:0) after 1m0s
[22:33:31.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:42:0)
[22:33:31.520] Timer tick, asking Buildbucket for the build status
[22:33:32.019] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:32.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:43:0) after 1m0s
[22:34:32.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:43:0)
[22:34:32.113] Timer tick, asking Buildbucket for the build status
[22:34:32.299] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:32.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:44:0) after 1m0s
[22:35:32.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:44:0)
[22:35:32.321] Timer tick, asking Buildbucket for the build status
[22:35:32.993] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:32.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:45:0) after 1m0s
[22:36:33.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:45:0)
[22:36:33.018] Timer tick, asking Buildbucket for the build status
[22:36:33.590] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:33.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:46:0) after 1m0s
[22:37:33.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:46:0)
[22:37:33.852] Timer tick, asking Buildbucket for the build status
[22:37:33.994] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:33.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:47:0) after 1m0s
[22:38:34.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:47:0)
[22:38:34.330] Timer tick, asking Buildbucket for the build status
[22:38:35.156] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:35.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:48:0) after 1m0s
[22:39:35.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:48:0)
[22:39:35.302] Timer tick, asking Buildbucket for the build status
[22:39:35.519] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:35.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:49:0) after 1m0s
[22:40:35.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:49:0)
[22:40:35.537] Timer tick, asking Buildbucket for the build status
[22:40:35.782] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:35.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:50:0) after 1m0s
[22:41:35.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:50:0)
[22:41:35.823] Timer tick, asking Buildbucket for the build status
[22:41:37.411] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:37.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:51:0) after 1m0s
[22:42:37.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:51:0)
[22:42:37.437] Timer tick, asking Buildbucket for the build status
[22:42:39.082] Build 8891342148815527936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:39.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056772211241880032:52:0) after 1m0s
[22:43:29.130] Received PubSub notification, asking Buildbucket for the build status
[22:43:33.278] Build 8891342148815527936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:43:33.278] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578955408571260",
"created_by": "project:chromium",
"created_ts": "1578952376502026",
"id": "8891342148815527936",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bfd8bf55775d00438efa2fef33587ad4eb723f17\"}}",
"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-95-51t4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167337, \"got_angle_revision\": \"c6ff255b602138b0f2f879e0fb5a764e4bb2c640\", \"got_dawn_revision\": \"15c442e941fbabc6bf0055ef3583cf5bfabbaa11\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"bfd8bf55775d00438efa2fef33587ad4eb723f17\", \"got_revision_cp\": \"refs/heads/master@{#730860}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"a624d80f0f56655e3f76804735c718e8c18d730b\", \"got_v8_revision\": \"3d04bd15b02d40f716b49dbb1cb97bb13c40741a\", \"got_v8_revision_cp\": \"refs/heads/8.1.170@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bfd8bf55775d00438efa2fef33587ad4eb723f17\", \"swarm_hashes_refs/heads/master(at){#730860}_without_patch\": {\"accessibility_unittests\": \"c06e921e1c3ba4251f250ef482be158f1eb37715\", \"angle_unittests\": \"b201be37a76612eb66490c9ed5c93b22d82d51b4\", \"app_shell_unittests\": \"764d1c4fd9dae833585147c1ea0500804c2edf91\", \"aura_unittests\": \"35e2b6be0a4691a00096c28470ff2613bf775607\", \"base_unittests\": \"b702881b5bda2df32d2dd0b367cc00026c305583\", \"base_util_unittests\": \"2a4bb8ea64f42a255047ac407569d670e8fd3535\", \"blink_common_unittests\": \"a8632b362007204fb83bda56a1c0da96926cb5ea\", \"blink_fuzzer_unittests\": \"1622561d87a86415bf91f3f94f75b0d3d936b8a7\", \"blink_heap_unittests\": \"78bb116f0cc04a26694c16e15c87041569e8a554\", \"blink_platform_unittests\": \"27aee67e46eccd731c6cac08f7d896d3313f05f6\", \"blink_python_tests\": \"1679c111fcfae20f3aac8837b0d5f1375b94910e\", \"blink_unittests\": \"814fb8383cd14c3beb2f256c4204da89e688225c\", \"blink_web_tests\": \"cc5e9b35be357537f55f89053246e20f683a8a4e\", \"boringssl_crypto_tests\": \"ff3b5c6461ef9d3189e80404f6d7d347a313a436\", \"boringssl_ssl_tests\": \"be1114f11ab0113bc51ceb41c777bc24b65ea2f0\", \"browser_tests\": \"d3871133ae5b5983162e5d33090caa41d0ac20e5\", \"cacheinvalidation_unittests\": \"c6b6631e468acc770e6575dbe0646c87188f7fcb\", \"capture_unittests\": \"c734538f3ccd19ef4e623a0eefe465b13dd89416\", \"cast_unittests\": \"06e1b78d01afab6c09af9fb2d5cbb1e9b7c7d8aa\", \"cc_unittests\": \"ff47d9f8826eb0db37d3709cb61f7027296c7217\", \"chrome_app_unittests\": \"fa016fc13d14934a1d023f4992fb23b3a8818221\", \"chromedriver_unittests\": \"d55f1af6ff844dfcdbeb1de645e9c36c5f321a7c\", \"components_browsertests\": \"9270574952578f023b406029c442110891f8b3af\", \"components_unittests\": \"6634cc65fa96a2b67afba3542172729659202ac4\", \"compositor_unittests\": \"4149f1f5d4ed88870b39cc06a0afaec348f53028\", \"content_browsertests\": \"49641d1464210c9be03600aa861255a39c73054f\", \"content_shell_crash_test\": \"87adce0d5a63de2f2ba06900cc0be025d12770b9\", \"content_unittests\": \"2b3cc2dab24a71a24a9811adad214fc7e2f30a38\", \"crashpad_tests\": \"76f2a7464c8b4c6b3b3e560b25333fed3584a6af\", \"cronet_tests\": \"adc6733b2188e46d625a9bb8c1cb41de917f3913\", \"cronet_unittests\": \"44e350f9d2414c9daca483d3e8021ca340a59ae3\", \"crypto_unittests\": \"614d7a6840d2079d1b9adcddaa6c53ef80c04c47\", \"dbus_unittests\": \"492fc889bd2d1a72f4fd57ec3552a62526b7fd3a\", \"device_unittests\": \"a7b4f774e51f5694aacf52055ea671463f8170fb\", \"devtools_lint_check\": \"94bfb9913dfd14c0318faf87227ec9a6381aaa99\", \"devtools_type_check\": \"97e5a26c764c28fb934447a3dc8572caeb6926d1\", \"display_unittests\": \"1169b91035eb8e6650342e81551f9141dfcb1a78\", \"events_unittests\": \"2e4d00ebc3c507280d8a4726916b8446ba8cde84\", \"extensions_browsertests\": \"c038c1b744a986f13e2d4ef20791c99ba471cbd5\", \"extensions_unittests\": \"6e1efb4e03ab409ec12353370874a34e609babec\", \"filesystem_service_unittests\": \"610668b659de2ccf1f782149e7a943c5d3fc74b4\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"66513e84e08f3df06af8f4c895c90bb43d09f42d\", \"gfx_unittests\": \"0d9f9fa01fc40e0379fd2d287710d534f4128375\", \"gin_unittests\": \"0748fa7aa394f1247eeaad101c3c3d0239765921\", \"google_apis_unittests\": \"a45f9784816f1e9d3f5fc8d244264653d1ae8fa0\", \"gpu_unittests\": \"61e4137c812b48f3d32829cdbe73124e633ca16e\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"9e08b93671011afbea741955e96e204f0de4c75e\", \"headless_browsertests\": \"fc08f3284e444353d6f1c7f951d9c9672ff5cbea\", \"headless_unittests\": \"39dc4c4c2cf6747f4e7192ab9aaa8d163a5bac23\", \"interactive_ui_tests\": \"3a1673e06026b27975b4d7a7316b8fcc2b28c4a3\", \"ipc_tests\": \"1771f2b40d28df73281da13eb3e93e2c9b87934f\", \"jingle_unittests\": \"14b4ce92b82ae7545a42a46c8a8904dbdd4941aa\", \"latency_unittests\": \"2bd67b9c87c7cc01354bc7a8f5931b61b09200bc\", \"libjingle_xmpp_unittests\": \"c8c1a6edf86cc1b2290b396380d358d5d1aadd29\", \"media_blink_unittests\": \"cc6bdc0681108480a34002da32e1e7b32fa8495a\", \"media_service_unittests\": \"86b3ebe8e5fef48c98212504ac3c59f3942948d0\", \"media_unittests\": \"f8eb464b70c9dc812368ba16981922ce6aa0b52b\", \"message_center_unittests\": \"794f6bb40a6a502abdfbd6c4142c3d0ca275232a\", \"metrics_python_tests\": \"6f9e841caddc8942c25dc275212212c5cf1e0c4c\", \"midi_unittests\": \"d56d9808ee7c7e1c9e45f30946345eeb38041bb6\", \"mojo_core_unittests\": \"ff43172ff3b1abd63f3893b5787c21103de31b42\", \"mojo_unittests\": \"ed664223c64beab2c031cd101da2ca50c50ff60c\", \"nacl_helper_nonsfi_unittests\": \"4c6a5e632118cea91f4fb40b751bbb44bddd16f6\", \"nacl_loader_unittests\": \"670fa61865d5a0816290a8937e40a554de2b722d\", \"native_theme_unittests\": \"3b1edc9f8efa3142c0bb99e10f3a324300ed17a6\", \"net_unittests\": \"8ad3a43d8e720ff2b76d092c75dcb34250663d18\", \"pdf_unittests\": \"ff8ca3ac0d48e61ecefbda4fe3e3b440f711c8ac\", \"perfetto_unittests\": \"d6139bc9fa535fb7ca8da2df5fe73ce7bcfb3ae4\", \"ppapi_unittests\": \"79e9d469e241debe359510c10c68e88d3d9865e8\", \"printing_unittests\": \"9f439ad42ea5f98b3c95007305ff53033ea80516\", \"remoting_unittests\": \"db2820ffb320fd00bacd4c52d900c5e3983c77e1\", \"sandbox_linux_unittests\": \"e8096309dda2de61d95651f37b1ac97887faa9ea\", \"service_manager_unittests\": \"9fb7d3cc791f886a48ceea7e96f735487ba5a28e\", \"services_unittests\": \"ef43ce69631c67f92966f80fb392bd6310f99317\", \"shell_dialogs_unittests\": \"ea0075ea96aee6018b1e2e7de73635019f0403ad\", \"skia_unittests\": \"00d92ae260685c4a22f667b171818ea6c55bb17e\", \"snapshot_unittests\": \"cc72de919a7cf4b6762b02cfccb45ba3533ffe36\", \"sql_unittests\": \"fe759ef4aa20c33a7c7cd161604c23c2d7cf7a1a\", \"storage_unittests\": \"4fb31d50ec083ea350116d8e1292a5e0b8a4856a\", \"sync_integration_tests\": \"d6060a18c110cffd8664c825acf1751f1557a047\", \"telemetry_gpu_unittests\": \"4e68074654edb4fcafa6a97876910b6de6a506a6\", \"telemetry_perf_unittests\": \"3b000b65d78852c09186533daa8ea82d16086b13\", \"telemetry_unittests\": \"ed2d98e8e9a374f08924489c93825425d46160f3\", \"traffic_annotation_auditor_unittests\": \"c5d244617f67cdd98e4a54c90df161f1ec6064c1\", \"ui_base_unittests\": \"3b68e87f0b48111d23a4b15d2e998dc263357f9c\", \"ui_touch_selection_unittests\": \"b49733167ff649775eca2a6be0248e2e0f05e5cd\", \"unit_tests\": \"3921c713ae415ef9038a2840b6405093f97bcdaf\", \"url_unittests\": \"4c9775a2c41be2fa76d5b6b4410225d27d758853\", \"views_perftests\": \"20f5f15ebb8752c2eac41dfb28cf47c4bdf1925c\", \"views_unittests\": \"4438a46e007e9b65361803de177541c294d06ab8\", \"viz_unittests\": \"1afe37e4a34f97a31d21b47badc9dfb8c80a0bcd\", \"vr_common_unittests\": \"7c7952e4eb3a881df3443ab735010dbc5669b58f\", \"vr_pixeltests\": \"105c52402ce4311d9dcdbb5cbc4894fb6168db62\", \"webdriver_wpt_tests\": \"cee891b32259493e49a557c6eac5e666971e5013\", \"weblayer_browsertests\": \"7fa336c6cf7db250e3ee9b50b11e2c8ad76579b0\", \"wm_unittests\": \"722eab080bbd0f25dae98223357ecbe8919aec04\", \"wtf_unittests\": \"a0040c89c1fd3db60c86cc03f14697ebfc3dc817\", \"xr_browser_tests\": \"c4b2345d2df2d7e7a3eed9cf3d972ef60a7da1e4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_86caf262f74ae694bec00fbb86541daa2df96eb35c1a4d9a06c3c1dcd129237e_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_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-95-51t4\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4752-73c7603\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578952744948969",
"status": "COMPLETED",
"status_changed_ts": "1578955408875864",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167337",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bfd8bf55775d00438efa2fef33587ad4eb723f17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bfd8bf55775d00438efa2fef33587ad4eb723f17",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056772211241880032",
"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/8891342148815527936/+/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:49b9b7f8058a8710",
"user_agent:luci-scheduler"
],
"updated_ts": "1578955408879754",
"url": "https://ci.chromium.org/b/8891342148815527936",
"utcnow_ts": "1578955413196521"
}
}
[22:43:33.278] Invocation finished in 50m38.474827922s with status SUCCEEDED