[18:19:44.059] New invocation is queued and will start shortly
[18:19:46.932] Starting the invocation (attempt 1)
[18:19:46.969] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:19:46.969] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:19:46.969] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058416368729870208",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a36c6e4dac5ae79dc0307b096ef982fc3f4479d7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9058416368729870208",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a36c6e4dac5ae79dc0307b096ef982fc3f4479d7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a36c6e4dac5ae79dc0307b096ef982fc3f4479d7",
"gitiles_ref:refs/heads/master"
]
}
[18:19:48.126] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577384387320334",
"id": "8892986304640299504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a36c6e4dac5ae79dc0307b096ef982fc3f4479d7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577384387689781",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166606",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a36c6e4dac5ae79dc0307b096ef982fc3f4479d7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a36c6e4dac5ae79dc0307b096ef982fc3f4479d7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058416368729870208",
"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/8892986304640299504/+/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": "1577384387689884",
"url": "https://ci.chromium.org/b/8892986304640299504",
"utcnow_ts": "1577384388118096"
}
}
[18:19:48.126] Task URL: https://ci.chromium.org/b/8892986304640299504
[18:19:48.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:2:0) after 1m0s
[18:20:48.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:2:0)
[18:20:48.519] Timer tick, asking Buildbucket for the build status
[18:20:48.661] Build 8892986304640299504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:48.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:3:0) after 1m0s
[18:21:48.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:3:0)
[18:21:48.817] Timer tick, asking Buildbucket for the build status
[18:21:49.103] Build 8892986304640299504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:49.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:4:0) after 1m0s
[18:22:49.174] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:4:0)
[18:22:49.174] Timer tick, asking Buildbucket for the build status
[18:22:49.576] Build 8892986304640299504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:49.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:5:0) after 1m0s
[18:23:49.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:5:0)
[18:23:49.740] Timer tick, asking Buildbucket for the build status
[18:23:49.960] Build 8892986304640299504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:49.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:6:0) after 1m0s
[18:24:06.063] Received PubSub notification, asking Buildbucket for the build status
[18:24:06.231] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:50.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:6:0)
[18:24:50.068] Timer tick, asking Buildbucket for the build status
[18:24:50.312] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:50.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:8:0) after 1m0s
[18:25:50.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:8:0)
[18:25:50.477] Timer tick, asking Buildbucket for the build status
[18:25:50.754] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:50.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:9:0) after 1m0s
[18:26:50.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:9:0)
[18:26:50.954] Timer tick, asking Buildbucket for the build status
[18:26:51.372] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:51.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:10:0) after 1m0s
[18:27:51.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:10:0)
[18:27:51.510] Timer tick, asking Buildbucket for the build status
[18:27:52.144] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:52.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:11:0) after 1m0s
[18:28:52.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:11:0)
[18:28:52.427] Timer tick, asking Buildbucket for the build status
[18:28:53.052] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:53.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:12:0) after 1m0s
[18:29:53.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:12:0)
[18:29:53.164] Timer tick, asking Buildbucket for the build status
[18:29:53.347] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:53.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:13:0) after 1m0s
[18:30:53.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:13:0)
[18:30:53.608] Timer tick, asking Buildbucket for the build status
[18:30:53.796] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:53.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:14:0) after 1m0s
[18:31:53.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:14:0)
[18:31:53.960] Timer tick, asking Buildbucket for the build status
[18:31:54.216] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:54.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:15:0) after 1m0s
[18:32:54.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:15:0)
[18:32:54.316] Timer tick, asking Buildbucket for the build status
[18:32:54.659] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:54.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:16:0) after 1m0s
[18:33:54.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:16:0)
[18:33:54.744] Timer tick, asking Buildbucket for the build status
[18:33:54.903] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:54.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:17:0) after 1m0s
[18:34:54.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:17:0)
[18:34:54.930] Timer tick, asking Buildbucket for the build status
[18:34:55.114] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:55.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:18:0) after 1m0s
[18:35:55.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:18:0)
[18:35:55.408] Timer tick, asking Buildbucket for the build status
[18:35:55.586] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:55.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:19:0) after 1m0s
[18:36:56.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:19:0)
[18:36:56.095] Timer tick, asking Buildbucket for the build status
[18:36:56.471] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:56.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:20:0) after 1m0s
[18:37:56.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:20:0)
[18:37:56.444] Timer tick, asking Buildbucket for the build status
[18:37:56.843] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:56.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:21:0) after 1m0s
[18:38:56.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:21:0)
[18:38:56.891] Timer tick, asking Buildbucket for the build status
[18:38:57.186] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:57.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:22:0) after 1m0s
[18:39:57.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:22:0)
[18:39:57.288] Timer tick, asking Buildbucket for the build status
[18:39:57.535] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:57.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:23:0) after 1m0s
[18:40:57.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:23:0)
[18:40:57.898] Timer tick, asking Buildbucket for the build status
[18:40:58.217] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:58.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:24:0) after 1m0s
[18:41:58.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:24:0)
[18:41:58.688] Timer tick, asking Buildbucket for the build status
[18:41:58.873] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:58.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:25:0) after 1m0s
[18:42:58.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:25:0)
[18:42:58.938] Timer tick, asking Buildbucket for the build status
[18:42:59.096] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:26:0) after 1m0s
[18:43:59.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:26:0)
[18:43:59.117] Timer tick, asking Buildbucket for the build status
[18:44:00.254] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:00.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:27:0) after 1m0s
[18:45:00.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:27:0)
[18:45:00.360] Timer tick, asking Buildbucket for the build status
[18:45:00.655] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:00.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:28:0) after 1m0s
[18:46:00.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:28:0)
[18:46:00.749] Timer tick, asking Buildbucket for the build status
[18:46:00.961] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:00.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:29:0) after 1m0s
[18:47:01.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:29:0)
[18:47:01.071] Timer tick, asking Buildbucket for the build status
[18:47:01.704] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:01.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:30:0) after 1m0s
[18:48:01.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:30:0)
[18:48:01.772] Timer tick, asking Buildbucket for the build status
[18:48:02.652] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:02.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:31:0) after 1m0s
[18:49:02.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:31:0)
[18:49:02.735] Timer tick, asking Buildbucket for the build status
[18:49:02.983] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:02.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:32:0) after 1m0s
[18:50:03.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:32:0)
[18:50:03.003] Timer tick, asking Buildbucket for the build status
[18:50:03.202] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:03.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:33:0) after 1m0s
[18:51:03.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:33:0)
[18:51:03.350] Timer tick, asking Buildbucket for the build status
[18:51:03.700] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:03.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:34:0) after 1m0s
[18:52:03.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:34:0)
[18:52:03.722] Timer tick, asking Buildbucket for the build status
[18:52:03.939] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:03.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:35:0) after 1m0s
[18:53:03.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:35:0)
[18:53:03.965] Timer tick, asking Buildbucket for the build status
[18:53:04.527] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:04.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:36:0) after 1m0s
[18:54:04.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:36:0)
[18:54:04.603] Timer tick, asking Buildbucket for the build status
[18:54:04.749] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:04.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:37:0) after 1m0s
[18:55:04.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:37:0)
[18:55:04.776] Timer tick, asking Buildbucket for the build status
[18:55:05.395] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:05.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:38:0) after 1m0s
[18:56:05.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:38:0)
[18:56:05.456] Timer tick, asking Buildbucket for the build status
[18:56:05.613] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:05.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:39:0) after 1m0s
[18:57:05.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:39:0)
[18:57:05.637] Timer tick, asking Buildbucket for the build status
[18:57:06.118] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:06.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:40:0) after 1m0s
[18:58:06.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:40:0)
[18:58:06.142] Timer tick, asking Buildbucket for the build status
[18:58:06.793] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:06.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:41:0) after 1m0s
[18:59:06.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:41:0)
[18:59:06.826] Timer tick, asking Buildbucket for the build status
[18:59:07.339] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:07.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:42:0) after 1m0s
[19:00:07.360] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:42:0)
[19:00:07.360] Timer tick, asking Buildbucket for the build status
[19:00:07.768] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:07.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:43:0) after 1m0s
[19:01:07.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:43:0)
[19:01:07.787] Timer tick, asking Buildbucket for the build status
[19:01:07.983] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:07.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:44:0) after 1m0s
[19:02:08.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:44:0)
[19:02:08.007] Timer tick, asking Buildbucket for the build status
[19:02:08.273] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:08.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:45:0) after 1m0s
[19:03:08.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:45:0)
[19:03:08.299] Timer tick, asking Buildbucket for the build status
[19:03:08.489] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:08.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:46:0) after 1m0s
[19:04:08.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:46:0)
[19:04:08.503] Timer tick, asking Buildbucket for the build status
[19:04:08.864] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:08.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:47:0) after 1m0s
[19:05:08.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:47:0)
[19:05:08.890] Timer tick, asking Buildbucket for the build status
[19:05:09.466] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:09.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:48:0) after 1m0s
[19:06:09.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:48:0)
[19:06:09.513] Timer tick, asking Buildbucket for the build status
[19:06:09.768] Build 8892986304640299504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:09.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058416368729870208:49:0) after 1m0s
[19:06:44.322] Received PubSub notification, asking Buildbucket for the build status
[19:06:44.548] Build 8892986304640299504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:06:44.548] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577387203362159",
"created_by": "project:chromium",
"created_ts": "1577384387320334",
"id": "8892986304640299504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a36c6e4dac5ae79dc0307b096ef982fc3f4479d7\"}}",
"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-51-ayoi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166606, \"got_angle_revision\": \"01dd6f6ca430a5c5bfd9d237b5569abd835694fc\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"a36c6e4dac5ae79dc0307b096ef982fc3f4479d7\", \"got_revision_cp\": \"refs/heads/master@{#727469}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6e3a387c01598240a7a8722ab8cbd1015ec1cd0a\", \"got_v8_revision\": \"53366c4eab3aa7def56310d7cbafc23c33179bc6\", \"got_v8_revision_cp\": \"refs/heads/8.1.75@{#1}\", \"got_webrtc_revision\": \"26762d0425ffd15af9ddc3ae669373668827ea00\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30125}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a36c6e4dac5ae79dc0307b096ef982fc3f4479d7\", \"swarm_hashes_refs/heads/master(at){#727469}_without_patch\": {\"accessibility_unittests\": \"a8e0c6f8abb268c5e2a4b3181357a58231f524e5\", \"angle_unittests\": \"47743b3993e1defe93d4f0bc9dde6fdd78cd7a37\", \"app_shell_unittests\": \"6f2907db25910f398585634d3fe56ccd14a179bb\", \"aura_unittests\": \"3cb62e017faae8abcfeaefa2e9a3d0b3680f8334\", \"base_unittests\": \"5df7688d7c9719816869c1b824006dbac29f95ec\", \"base_util_unittests\": \"0df9370fa5d798ea032a6eba290a8aa66632aff7\", \"blink_common_unittests\": \"d08506bbc25ff83783b26b1b79eb91df2d3634fe\", \"blink_fuzzer_unittests\": \"d976d6cc1138681eb26505f0fa02097f13b30aca\", \"blink_heap_unittests\": \"32de246ecac43cc223548654197a82d87280e4da\", \"blink_platform_unittests\": \"be84912656449a5cc1c3235fa82742a024a1f4cf\", \"blink_python_tests\": \"e3ab48cc253ed8191dfa2591ea6e2b5382fb90fd\", \"blink_unittests\": \"2c6d1225e7add0b80ec4a5b343bb16d102bf55f3\", \"blink_web_tests\": \"9abb81317146ebfefa4ad95cf65936c11b16e56e\", \"boringssl_crypto_tests\": \"d5ee27370b765d1b8841eec2c897223ba713a9fd\", \"boringssl_ssl_tests\": \"9068614d6371f901eca99c2e47a55c53cfe48889\", \"browser_tests\": \"5cebd7d3336b1c610015e41d31dabfbd23ec888a\", \"cacheinvalidation_unittests\": \"2824919316cba1f74f15bb797bbaa86aedd30e7a\", \"capture_unittests\": \"2b09f3f413e765b6f220a48b2a9dce6466c71bfd\", \"cast_unittests\": \"8b07f881979c19cc0e0c8ee10d0a2331c0808189\", \"cc_unittests\": \"5195c7aecb20c12ff29d056341f0c3ff6a35c7a3\", \"chrome_app_unittests\": \"44ade4ff10555a52f367daee9bc15281f3ccb7b6\", \"chromedriver_unittests\": \"bbe89742746ae9e15792f5525edfd3fa5fb698d8\", \"components_browsertests\": \"7876a57d67915bb61f63c17197d5ef9871544a45\", \"components_unittests\": \"f3d040cfbc10f4fcd9ec84117c401d4f5a66835b\", \"compositor_unittests\": \"a3c8fa4dd85b459aaa25e4fa22a89c9307f38f77\", \"content_browsertests\": \"6eec1a5af620cd9475bdcb20258eb8b29c570adf\", \"content_shell_crash_test\": \"49091bf4fba2b31caed8d3be99a7197c3cbab757\", \"content_unittests\": \"f8eb393922d4efbb72c88b7f89d2d5836172e085\", \"crashpad_tests\": \"ccc9f4fdaf39f3524daf060f179397eb9218e474\", \"cronet_tests\": \"6fdaf953c230c44bf83b7840958e66e9cd6b509b\", \"cronet_unittests\": \"eb44cbd76da4be32232fab1cbedcd3b5e600da65\", \"crypto_unittests\": \"a65ec25a716e7b0fe81869a60746741c8cd66140\", \"dbus_unittests\": \"f0018d7e01d6ecb1125ab810953758e99e9ca795\", \"device_unittests\": \"24560af81310bbe7c4bb6a0975568894955ac511\", \"devtools_lint_check\": \"f5ef4bbd5230ceca8e6b62aa06ad4d93f07aaee9\", \"devtools_type_check\": \"0560d4eae584ad288c2a1900ea29c456fa9b4b3b\", \"display_unittests\": \"a3ddcaf6d50b9ace7479f793c3180d047458dfd7\", \"events_unittests\": \"889fd80ac9f90fb8af12d4ca2a0bbdaeeb62809c\", \"extensions_browsertests\": \"271bc5af299a7f098f449ff6ac62d201d70c32f1\", \"extensions_unittests\": \"0f32372ca09a860e7b7999592871c08e831aefa1\", \"filesystem_service_unittests\": \"32e04201da4bfef3287259d687bce1284907e9dc\", \"flatbuffers_unittests\": \"35d92a748edf43f648bd80c0c655e609f5a52216\", \"gcm_unit_tests\": \"0fbf4e90b6c029581b17eb078a574bf61fd8fec8\", \"gfx_unittests\": \"acd45db3e4f0dc04917c846ee7600b86630b7512\", \"gin_unittests\": \"11239c66e172474601704bef92c7a6fc9375bbd1\", \"google_apis_unittests\": \"1af2fb55120892306739ddbea4aebeb2c158b99e\", \"gpu_unittests\": \"ebefcd08f55d51594345860f11733cd116f9ec6b\", \"grit_python_unittests\": \"92a851f89811e715f33e61624f055bd6c7226997\", \"gwp_asan_unittests\": \"9a6edee672ab972a43770c3faf1f5a0fdc7693a0\", \"headless_browsertests\": \"521dfcf2cf75766292edbd9d5dab2b5c59bf9a16\", \"headless_unittests\": \"90efe85afa62f9e3ce9cd020479ae4bafd858e34\", \"interactive_ui_tests\": \"b586eaf2310704540f0ad236827bf13086f1741d\", \"ipc_tests\": \"295b219fbc4ea7eab14fb8e17e6cfe909c3c4493\", \"jingle_unittests\": \"998464fcd256041d6b0a62831d0e034774bdfe60\", \"latency_unittests\": \"ad7c345213d253d1fc2c393d11ec71c073197e56\", \"libjingle_xmpp_unittests\": \"7b33aaf23dd6da3ac5bad3dd71176f2507b1d0be\", \"media_blink_unittests\": \"0092b3f939e803938051830dec7e926c2b8eb733\", \"media_service_unittests\": \"fe3cd93f3ba487050d0394f8bec8e85a57af974f\", \"media_unittests\": \"5c1fca69c9d718b7c4bc9548eee398bfac9cebf9\", \"message_center_unittests\": \"bc810a5c3db463a4684660d4cfbb306a43bd1e78\", \"metrics_python_tests\": \"59cf26718a324a20a72bfecf989de09a4cdea39e\", \"midi_unittests\": \"a5ab3bff8bec8ef1f7e8f759dbf65a45b5af975f\", \"mojo_core_unittests\": \"970802ed1e72eb3260c0d2b6299d4ed65fc07351\", \"mojo_unittests\": \"56a6cbb9f10b43b74b03c5a1d2aae7bf1301e955\", \"nacl_helper_nonsfi_unittests\": \"34c7aae2b7d5ec9cde6e85a78b6a0d47d1175759\", \"nacl_loader_unittests\": \"0f5278c18748dca6ab1f4fe18c93fe2fcbc4ff49\", \"native_theme_unittests\": \"f8f68a5240d99287377714d31be1057011daa5ec\", \"net_unittests\": \"2f12c79a44ef12bf23e39153929125a426b38372\", \"pdf_unittests\": \"b075e5c91a11b4adaa0c29da145544598414dfff\", \"perfetto_unittests\": \"001418ce632502d37e98b9f34feef3fda617b38e\", \"ppapi_unittests\": \"69dfe721b156b82e7cc6ce833f69d980236b7306\", \"printing_unittests\": \"cd11a70e16180c829808c4616f3b74bd3fea541b\", \"remoting_unittests\": \"027c6d6999bb3d9706f007df75acba63ff3272cb\", \"sandbox_linux_unittests\": \"284b273d1210f7b8c324d3f0da1151bfe71a8acc\", \"service_manager_unittests\": \"f43429229c246dae57baffa162ff9835ffb02acc\", \"services_unittests\": \"9f293cb4e2e8fb4ade9d87b6ce917c8de782a85c\", \"shell_dialogs_unittests\": \"39e5c26b7abe545c11a9ce1f2100e3d791c51572\", \"skia_unittests\": \"457d7e22ff882b7af089a73c5e0b7494586b2968\", \"snapshot_unittests\": \"f643ff6a06f2481f4109471e8fef8b99d65c0568\", \"sql_unittests\": \"fe641a557b2f70a9f4bbeb7199e0c2d4a6b064f6\", \"storage_unittests\": \"a6796582e472c1bf36352954868c00401e563202\", \"sync_integration_tests\": \"8e7e13678a93344f3088e5709fccfface28038ba\", \"telemetry_gpu_unittests\": \"353822766a85771fef8faf6c6dca818a64ca4614\", \"telemetry_perf_unittests\": \"16120a930a7f091b5c67e06ba22bcc02c66c5cfb\", \"telemetry_unittests\": \"ffa04fa35fd0dc7fea0ed7f197da3fa4fed8221c\", \"traffic_annotation_auditor_unittests\": \"8fbf7b544bfe529da387a7d6641ed7c190864d89\", \"ui_base_unittests\": \"2abaeae0ac51b243456d224c90632af147b04f44\", \"ui_touch_selection_unittests\": \"7bbf11f8f45763bb507482243989468bfdb01c22\", \"unit_tests\": \"9a56ca53bc4dead13d846f5680acdb4e1bd7e526\", \"url_unittests\": \"036bebd50fc4b19e93f97204f53855189d2f7103\", \"views_perftests\": \"51def548c37845441ce92ea1cec17ff74919bc6a\", \"views_unittests\": \"68dff3fcbaf702728d43298df1746bd4d668e3d6\", \"viz_unittests\": \"10aaf799796949cd74ff411407da3a1f2e9b2285\", \"vr_common_unittests\": \"027c7e1c7564dbfa45dc0d7f1ddbf0bebe804e33\", \"vr_pixeltests\": \"0ae5b36879eb94f8bcba2eaa53aa521ae7f495e4\", \"webdriver_wpt_tests\": \"2583e9efb0430f973e103b97c45b8f28abb46562\", \"weblayer_browsertests\": \"0b142e3ac62ffb508b1b44033c100f9168f72270\", \"wm_unittests\": \"4acde464139a145becf063d48d4074c78f7dfbcb\", \"wtf_unittests\": \"e5eec54b6b7a75dc16eb5a0f376c4b93c5911458\", \"xr_browser_tests\": \"61d290fe5432a576a8282a6a790affda767daadb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_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-51-ayoi\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577384644591829",
"status": "COMPLETED",
"status_changed_ts": "1577387203927810",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166606",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a36c6e4dac5ae79dc0307b096ef982fc3f4479d7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a36c6e4dac5ae79dc0307b096ef982fc3f4479d7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058416368729870208",
"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/8892986304640299504/+/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:495c4144b9b5c810",
"user_agent:luci-scheduler"
],
"updated_ts": "1577387203937883",
"url": "https://ci.chromium.org/b/8892986304640299504",
"utcnow_ts": "1577387204532969"
}
}
[19:06:44.548] Invocation finished in 47m0.512694702s with status SUCCEEDED