[18:00:47.181] New invocation is queued and will start shortly
[18:00:49.033] Starting the invocation (attempt 1)
[18:00:49.088] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:00:49.088] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:00:49.088] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053978309485524640",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3855d23e5722bfed39ed4af62c5e6f69b5e95fcf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053978309485524640",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3855d23e5722bfed39ed4af62c5e6f69b5e95fcf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3855d23e5722bfed39ed4af62c5e6f69b5e95fcf",
"gitiles_ref:refs/heads/master"
]
}
[18:00:49.903] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1581616849364958",
"id": "8888548246519221424",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3855d23e5722bfed39ed4af62c5e6f69b5e95fcf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581616849749517",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168564",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3855d23e5722bfed39ed4af62c5e6f69b5e95fcf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3855d23e5722bfed39ed4af62c5e6f69b5e95fcf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053978309485524640",
"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/8888548246519221424/+/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": "1581616849749659",
"url": "https://ci.chromium.org/b/8888548246519221424",
"utcnow_ts": "1581616849896044"
}
}
[18:00:49.903] Task URL: https://ci.chromium.org/b/8888548246519221424
[18:00:49.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:2:0) after 1m0s
[18:01:49.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:2:0)
[18:01:49.987] Timer tick, asking Buildbucket for the build status
[18:01:50.293] Build 8888548246519221424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:50.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:3:0) after 1m0s
[18:02:50.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:3:0)
[18:02:50.452] Timer tick, asking Buildbucket for the build status
[18:02:50.660] Build 8888548246519221424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:50.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:4:0) after 1m0s
[18:03:50.747] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:4:0)
[18:03:50.747] Timer tick, asking Buildbucket for the build status
[18:03:50.905] Build 8888548246519221424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:50.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:5:0) after 1m0s
[18:04:50.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:5:0)
[18:04:50.952] Timer tick, asking Buildbucket for the build status
[18:04:51.156] Build 8888548246519221424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:51.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:6:0) after 1m0s
[18:05:51.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:6:0)
[18:05:51.215] Timer tick, asking Buildbucket for the build status
[18:05:51.401] Build 8888548246519221424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:51.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:7:0) after 1m0s
[18:05:51.928] Received PubSub notification, asking Buildbucket for the build status
[18:05:52.549] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:51.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:7:0)
[18:06:51.489] Timer tick, asking Buildbucket for the build status
[18:06:52.161] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:52.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:9:0) after 1m0s
[18:07:52.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:9:0)
[18:07:52.303] Timer tick, asking Buildbucket for the build status
[18:07:52.525] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:52.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:10:0) after 1m0s
[18:08:52.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:10:0)
[18:08:52.566] Timer tick, asking Buildbucket for the build status
[18:08:52.818] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:52.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:11:0) after 1m0s
[18:09:52.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:11:0)
[18:09:52.912] Timer tick, asking Buildbucket for the build status
[18:09:53.023] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:53.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:12:0) after 1m0s
[18:10:53.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:12:0)
[18:10:53.195] Timer tick, asking Buildbucket for the build status
[18:10:53.361] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:53.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:13:0) after 1m0s
[18:11:53.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:13:0)
[18:11:53.464] Timer tick, asking Buildbucket for the build status
[18:11:54.257] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:54.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:14:0) after 1m0s
[18:12:54.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:14:0)
[18:12:54.309] Timer tick, asking Buildbucket for the build status
[18:12:54.501] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:54.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:15:0) after 1m0s
[18:13:54.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:15:0)
[18:13:54.578] Timer tick, asking Buildbucket for the build status
[18:13:54.830] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:54.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:16:0) after 1m0s
[18:14:54.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:16:0)
[18:14:54.838] Timer tick, asking Buildbucket for the build status
[18:14:55.003] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:55.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:17:0) after 1m0s
[18:15:55.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:17:0)
[18:15:55.032] Timer tick, asking Buildbucket for the build status
[18:15:55.296] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:55.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:18:0) after 1m0s
[18:16:55.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:18:0)
[18:16:55.343] Timer tick, asking Buildbucket for the build status
[18:16:55.505] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:55.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:19:0) after 1m0s
[18:17:55.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:19:0)
[18:17:55.489] Timer tick, asking Buildbucket for the build status
[18:17:55.815] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:55.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:20:0) after 1m0s
[18:18:55.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:20:0)
[18:18:55.846] Timer tick, asking Buildbucket for the build status
[18:18:56.024] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:56.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:21:0) after 1m0s
[18:19:56.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:21:0)
[18:19:56.155] Timer tick, asking Buildbucket for the build status
[18:19:56.353] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:56.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:22:0) after 1m0s
[18:20:56.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:22:0)
[18:20:56.549] Timer tick, asking Buildbucket for the build status
[18:20:56.708] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:56.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:23:0) after 1m0s
[18:21:56.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:23:0)
[18:21:56.939] Timer tick, asking Buildbucket for the build status
[18:21:57.125] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:57.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:24:0) after 1m0s
[18:22:57.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:24:0)
[18:22:57.145] Timer tick, asking Buildbucket for the build status
[18:22:57.278] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:57.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:25:0) after 1m0s
[18:23:57.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:25:0)
[18:23:57.329] Timer tick, asking Buildbucket for the build status
[18:23:57.714] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:57.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:26:0) after 1m0s
[18:24:57.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:26:0)
[18:24:57.821] Timer tick, asking Buildbucket for the build status
[18:24:57.986] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:57.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:27:0) after 1m0s
[18:25:58.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:27:0)
[18:25:58.068] Timer tick, asking Buildbucket for the build status
[18:25:58.223] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:58.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:28:0) after 1m0s
[18:26:58.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:28:0)
[18:26:58.305] Timer tick, asking Buildbucket for the build status
[18:26:58.458] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:58.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:29:0) after 1m0s
[18:27:58.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:29:0)
[18:27:58.605] Timer tick, asking Buildbucket for the build status
[18:27:59.006] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:30:0) after 1m0s
[18:28:59.088] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:30:0)
[18:28:59.088] Timer tick, asking Buildbucket for the build status
[18:28:59.637] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:59.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:31:0) after 1m0s
[18:29:59.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:31:0)
[18:29:59.796] Timer tick, asking Buildbucket for the build status
[18:29:59.968] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:59.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:32:0) after 1m0s
[18:31:00.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:32:0)
[18:31:00.093] Timer tick, asking Buildbucket for the build status
[18:31:00.338] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:33:0) after 1m0s
[18:32:00.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:33:0)
[18:32:00.532] Timer tick, asking Buildbucket for the build status
[18:32:01.001] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:01.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:34:0) after 1m0s
[18:33:01.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:34:0)
[18:33:01.101] Timer tick, asking Buildbucket for the build status
[18:33:01.229] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:35:0) after 1m0s
[18:34:01.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:35:0)
[18:34:01.553] Timer tick, asking Buildbucket for the build status
[18:34:01.704] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:01.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:36:0) after 1m0s
[18:35:01.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:36:0)
[18:35:01.983] Timer tick, asking Buildbucket for the build status
[18:35:02.165] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:02.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:37:0) after 1m0s
[18:36:02.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:37:0)
[18:36:02.204] Timer tick, asking Buildbucket for the build status
[18:36:02.419] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:02.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:38:0) after 1m0s
[18:37:02.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:38:0)
[18:37:02.572] Timer tick, asking Buildbucket for the build status
[18:37:02.826] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:02.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:39:0) after 1m0s
[18:38:03.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:39:0)
[18:38:03.069] Timer tick, asking Buildbucket for the build status
[18:38:03.451] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:03.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:40:0) after 1m0s
[18:39:03.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:40:0)
[18:39:03.640] Timer tick, asking Buildbucket for the build status
[18:39:04.571] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:04.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:41:0) after 1m0s
[18:40:04.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:41:0)
[18:40:04.888] Timer tick, asking Buildbucket for the build status
[18:40:05.465] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:05.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:42:0) after 1m0s
[18:41:05.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:42:0)
[18:41:05.624] Timer tick, asking Buildbucket for the build status
[18:41:05.830] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:05.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:43:0) after 1m0s
[18:42:05.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:43:0)
[18:42:05.850] Timer tick, asking Buildbucket for the build status
[18:42:05.974] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:05.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:44:0) after 1m0s
[18:43:06.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:44:0)
[18:43:06.169] Timer tick, asking Buildbucket for the build status
[18:43:06.347] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:06.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:45:0) after 1m0s
[18:44:06.407] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:45:0)
[18:44:06.407] Timer tick, asking Buildbucket for the build status
[18:44:07.448] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:07.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:46:0) after 1m0s
[18:45:07.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:46:0)
[18:45:07.481] Timer tick, asking Buildbucket for the build status
[18:45:07.655] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:07.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:47:0) after 1m0s
[18:46:07.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:47:0)
[18:46:07.663] Timer tick, asking Buildbucket for the build status
[18:46:07.803] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:07.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:48:0) after 1m0s
[18:47:07.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:48:0)
[18:47:07.860] Timer tick, asking Buildbucket for the build status
[18:47:08.116] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:08.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:49:0) after 1m0s
[18:48:08.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:49:0)
[18:48:08.238] Timer tick, asking Buildbucket for the build status
[18:48:08.451] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:08.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:50:0) after 1m0s
[18:49:08.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:50:0)
[18:49:08.479] Timer tick, asking Buildbucket for the build status
[18:49:08.685] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:08.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:51:0) after 1m0s
[18:50:08.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:51:0)
[18:50:08.754] Timer tick, asking Buildbucket for the build status
[18:50:08.958] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:08.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:52:0) after 1m0s
[18:51:09.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:52:0)
[18:51:09.017] Timer tick, asking Buildbucket for the build status
[18:51:09.198] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:09.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:53:0) after 1m0s
[18:52:09.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:53:0)
[18:52:09.175] Timer tick, asking Buildbucket for the build status
[18:52:10.007] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:10.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:54:0) after 1m0s
[18:53:10.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:54:0)
[18:53:10.157] Timer tick, asking Buildbucket for the build status
[18:53:10.341] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:10.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:55:0) after 1m0s
[18:54:10.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:55:0)
[18:54:10.398] Timer tick, asking Buildbucket for the build status
[18:54:10.762] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:10.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:56:0) after 1m0s
[18:55:11.218] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:56:0)
[18:55:11.218] Timer tick, asking Buildbucket for the build status
[18:55:11.400] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:11.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:57:0) after 1m0s
[18:56:11.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:57:0)
[18:56:11.731] Timer tick, asking Buildbucket for the build status
[18:56:12.199] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:12.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:58:0) after 1m0s
[18:57:12.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:58:0)
[18:57:12.430] Timer tick, asking Buildbucket for the build status
[18:57:12.862] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:12.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:59:0) after 1m0s
[18:58:12.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:59:0)
[18:58:12.872] Timer tick, asking Buildbucket for the build status
[18:58:13.036] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:13.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:60:0) after 1m0s
[18:59:13.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:60:0)
[18:59:13.307] Timer tick, asking Buildbucket for the build status
[18:59:13.465] Build 8888548246519221424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053978309485524640:61:0) after 1m0s
[19:00:05.041] Received PubSub notification, asking Buildbucket for the build status
[19:00:05.134] Build 8888548246519221424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:00:05.134] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1581620389674358",
"created_by": "project:chromium",
"created_ts": "1581616849364958",
"id": "8888548246519221424",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3855d23e5722bfed39ed4af62c5e6f69b5e95fcf\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-136-vl0f\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168564, \"got_angle_revision\": \"e82ab75a4ca8f4389a5f23b3a51d9388a92428e2\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3855d23e5722bfed39ed4af62c5e6f69b5e95fcf\", \"got_revision_cp\": \"refs/heads/master@{#741118}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"29cc245860746cb9ec174eba4b5f50bc8c6e790d\", \"got_v8_revision\": \"f63b3f364bf8823496fe6b3134780e7d2996a644\", \"got_v8_revision_cp\": \"refs/heads/8.2.68@{#1}\", \"got_webrtc_revision\": \"b28e57e72580b0269cecf91754b4c3a1937e0712\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30511}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3855d23e5722bfed39ed4af62c5e6f69b5e95fcf\", \"swarm_hashes_refs/heads/master(at){#741118}_without_patch\": {\"accessibility_unittests\": \"12d1b0748b4fbd1c532a0c1586922e4be086357b\", \"angle_unittests\": \"d81dd8a2b73cdaf2a31f3b52ff03a2f5146cee18\", \"app_shell_unittests\": \"38fe57a00e6d43b630a19b40e607f51139379f1e\", \"aura_unittests\": \"6d5cf9c59940c10948f3fb1edda093c5c44b350b\", \"base_unittests\": \"fe0b12a1efb25bd643ce9521e9b798de020dc7a5\", \"base_util_unittests\": \"21cd0e946cf4d6f7177b1bb2107d147d5b5ab73f\", \"blink_common_unittests\": \"3f7c445b178b066ef9147c15db151cc0dee02b8d\", \"blink_fuzzer_unittests\": \"773a7f2cdd2eebafa52262a5ed84ca5a696beaf8\", \"blink_heap_unittests\": \"ff7ee4aa6218e45f7a82316e18ed560a39d13f7c\", \"blink_platform_unittests\": \"2cbe75fc7a77c836991118cce7afcd60c6a97b3d\", \"blink_python_tests\": \"7a4b63d6dc9243a0f374f46eb4bbfe2dd7a561b2\", \"blink_unittests\": \"ddd50ae7d61e2a2bf2e8ca83f50c906e992e6f23\", \"blink_web_tests\": \"c64f0ce3e519307e94c695f77bf9313021abd56b\", \"boringssl_crypto_tests\": \"ec25072896452812b72798b95f2700d80c833475\", \"boringssl_ssl_tests\": \"46db2c0e1d853b40fede799aa28babddf9596d18\", \"browser_tests\": \"6e21ac613c9b097e9dd45a3bee3fe63bd71b4a52\", \"cacheinvalidation_unittests\": \"2891d9acf005b9b3fd4f41bc909d49790e49f060\", \"capture_unittests\": \"7d08bcf752c7a51ec4fae86f1d4ec12dd5a54184\", \"cast_unittests\": \"4a5d62d99d32cc95f16d2ed506189dd19853ed26\", \"cc_unittests\": \"cb3224404bd216d94c2ba2d2d1aa572c8a990bbe\", \"chrome_app_unittests\": \"10116dda532dab2602a42405957225be838b0c2f\", \"chromedriver_unittests\": \"fb9c5e8c783b42fe1dace937e859401f0890fcff\", \"components_browsertests\": \"4dea5f296a22e4b824313c2a148c84ee47bae0e4\", \"components_unittests\": \"85451b15de211b847eccde772c89c489cda2a855\", \"compositor_unittests\": \"8bc765ace7b6f0325981cf263799911e4a54d4c4\", \"content_browsertests\": \"a064a378dca556c03f25c7ab0393c228fab9207e\", \"content_shell_crash_test\": \"46b3a8171af644e5d88a54f112edde89bf9513eb\", \"content_unittests\": \"af322f742ef8f8ce469fddb97859f362c5ae3063\", \"crashpad_tests\": \"61f59444e22f9f22741e95996521b035abea8ea4\", \"cronet_tests\": \"3109899054e499d413a6da6aa59c4f27be157fdf\", \"cronet_unittests\": \"57ab7e04b31d97ba1ae74891963e105c72ca359e\", \"crypto_unittests\": \"0f41450b7cac87f87d9b52ea3c0fd00806c82469\", \"dbus_unittests\": \"f7baaf9ff88c33b6fbfdb9c743e9f946c4b3438d\", \"device_unittests\": \"65a19e5d59261dbf124828d6da1dc2f03ac990ef\", \"display_unittests\": \"53ab02badfa3b26176f9c5ec76e2d3f43db4df18\", \"events_unittests\": \"770f4e249f1b68235943797f8e13faa17a69ac59\", \"extensions_browsertests\": \"e0868bf04a8f35ac704c7dcfbf056c0d64c95fb4\", \"extensions_unittests\": \"95413d9bcddbdadcb378e6f83cbb992114d5918b\", \"filesystem_service_unittests\": \"76a56e66839cca114ea27307248354bf90781061\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"1d2540b9100b5ac6ff27f2122713465756ac85ee\", \"gfx_unittests\": \"e494efdafa2bf92fba7beb6e33fc3b05993da03f\", \"gin_unittests\": \"42a9947f45114c8a7c71dd2ce3060fe99b108d36\", \"google_apis_unittests\": \"b674e3bcccee1000acf3beef3f64ef28c7337d25\", \"gpu_unittests\": \"ab03166c5d4d6d58f03ffcb34a9a1d8b46eabd3b\", \"grit_python_unittests\": \"07488c096d20bb2a4e6d9280813fca6afbee6dc0\", \"gwp_asan_unittests\": \"097e2b0db57c270ad56854b2d56081b4db7332f5\", \"headless_browsertests\": \"ad381f8c1e4d22495397c6fa32c75a344a6a3df8\", \"headless_unittests\": \"5b0d4fcdaacffe105ae9c6bce591440e7d57566f\", \"interactive_ui_tests\": \"2cef9c23882703614fc7826cbd4ca4f443fe8935\", \"ipc_tests\": \"550c6d92a0d810877c020e80149255cf371b04e4\", \"jingle_unittests\": \"7173940234ad4f2bc7c12ae74a202d2260f9156f\", \"latency_unittests\": \"425ea4ff98b5f13d1d1a587acba8dff371a2577b\", \"libjingle_xmpp_unittests\": \"b62b78a229e4c108b569c5f0544bd142bfd69617\", \"media_blink_unittests\": \"7f9cdf19217e89695a3dc4da8a5ee2423eb2b37c\", \"media_service_unittests\": \"bed1b52d419dff8d19513d89140be3e661fe9a3f\", \"media_unittests\": \"26b8db9da0a89073a145d14d5af70abd9dc31b86\", \"message_center_unittests\": \"678a7fb7c102c0145b16fbdd89ffb1a6c04dee88\", \"metrics_python_tests\": \"fcc2762a1a7050e6a6310e87491e30be346bca3a\", \"midi_unittests\": \"64a98c94f6d7503c8780781cf65362ba0b7af3eb\", \"mojo_core_unittests\": \"33f533d093d13ecd2fecae324b04a6f019a7bf05\", \"mojo_unittests\": \"9cb9527bf0525746591d773a759ad54e0e4cf56d\", \"nacl_helper_nonsfi_unittests\": \"e5fb3c692c6c853357b72e6ee7aec1b3f34b13a4\", \"nacl_loader_unittests\": \"ee34f1ad4e5e6cb7e9fdaa4ef12f7fa64b59bcb9\", \"native_theme_unittests\": \"f9d18cced2254a25f8cbf380bfc449a7735e83ab\", \"net_unittests\": \"a145838b8882528c8f3240d7876d80ed70889bc9\", \"pdf_unittests\": \"3a6c1850d379f49d915e23b5e19180089f5be4a8\", \"perfetto_unittests\": \"88fb59373c7fabd9ce674d2c2739d97a1f081c5c\", \"ppapi_unittests\": \"d6c7cc6a5097519a97e02053471bd8bf6cb5ad09\", \"printing_unittests\": \"913bfb490ef38c7e06e4ee029b611129d64f18bc\", \"remoting_unittests\": \"9cdea78e7f3e43209a490f568a11cbe2b8fdc962\", \"sandbox_linux_unittests\": \"ff8c79717c11d4bc6c086468e0c69e22462f4255\", \"service_manager_unittests\": \"c690f215ceb296bf563d5eff0ab194609630fd5d\", \"services_unittests\": \"c354497dba52887e0fcada2772ec66307d696498\", \"shell_dialogs_unittests\": \"3ce8ccf52d921dc4c533b18098c6fcf1f19629f2\", \"skia_unittests\": \"42c93fae4125b4ffe0af364ded45cf2046eb634a\", \"snapshot_unittests\": \"af114a21137625c4b046c1a47c4abfe63806f1b4\", \"sql_unittests\": \"fcc63aaedb1efba0300332aa41dcc69aaab4650b\", \"storage_unittests\": \"c5e97ab97d2414177716cc9aaeb5467d4f60465b\", \"sync_integration_tests\": \"832fd5fa5888b2eabd4ae39150d3c618b4618061\", \"telemetry_gpu_unittests\": \"a8b6144ba326b697c71ae188e0dc7a78ec0387a7\", \"telemetry_perf_unittests\": \"f59c6e4f308e3437852ee3ee06fd1a97f217ad5b\", \"telemetry_unittests\": \"1f02e8b9233bbeb04a44d5c3df32fcc8ce9b8f9a\", \"traffic_annotation_auditor_unittests\": \"374c4c0cb15e15e889dd4059540e840b479876c9\", \"ui_base_unittests\": \"1325c522025990beedacc66a3facf283a5588b8c\", \"ui_touch_selection_unittests\": \"f7b456eab5e3321943cabc06d5f3ac739cf13ea7\", \"unit_tests\": \"b281df19c0bc0862ff0fd7d575ae3fb81487980f\", \"url_unittests\": \"af85fd1e30f2a88670fa26864490532a9e0bc5df\", \"views_perftests\": \"14ad8adbd189cc77cfeb9f3bdf66e6d230b0bc99\", \"views_unittests\": \"021a456a20fc18463203d4a0abed4aa4ac2b6de8\", \"viz_unittests\": \"df71aa1b54593226497be3092157c9393a2ff499\", \"vr_common_unittests\": \"817e21074ed542a8eb915c89b401c26368c2de05\", \"vr_pixeltests\": \"5e7d6d33fb7cb4d6427359f1701c5587f04e11d2\", \"webdriver_wpt_tests\": \"8cdfc2d246085dbaebadad9e783fb7a7f927d0e9\", \"weblayer_browsertests\": \"0e04aec76e8c37d7470db7c8f5a28a7b14f60ff2\", \"wm_unittests\": \"fcb24079f338870a236a36ce3c92697c001ebb75\", \"wtf_unittests\": \"a4c479d3894529ddaa67064dd0f305ed42f8e76d\", \"xr_browser_tests\": \"8dd8c084ecacf68775aca4b2fa021460af26c451\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_6e17dc7623fba43c9632527d18d71e4843b504e37694b559b7b91daecd01d18c_v2\", \"builder_a27b44a1648dd298adda85735042ac3d0ffdcfd6d22ed3e792b03614ce2ee968_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_d78b729059d6d7166c1c60b6c63641496a1541bf700cb46d40203a280149f161_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-136-vl0f\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581617103323720",
"status": "COMPLETED",
"status_changed_ts": "1581620404566855",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168564",
"builder:Linux Builder (dbg)",
"buildset:commit/git/3855d23e5722bfed39ed4af62c5e6f69b5e95fcf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3855d23e5722bfed39ed4af62c5e6f69b5e95fcf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053978309485524640",
"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/8888548246519221424/+/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:4a58876d07630c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581620404617102",
"url": "https://ci.chromium.org/b/8888548246519221424",
"utcnow_ts": "1581620405124674"
}
}
[19:00:05.134] Invocation finished in 59m17.982165031s with status SUCCEEDED