[04:27:50.575] New invocation is queued and will start shortly
[04:27:51.826] Starting the invocation (attempt 1)
[04:27:51.902] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:27:51.902] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:27:51.902] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052761097920471984",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2cd0af7ea20547c2471483ef2233f3b068db93c3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052761097920471984",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/2cd0af7ea20547c2471483ef2233f3b068db93c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2cd0af7ea20547c2471483ef2233f3b068db93c3",
"gitiles_ref:refs/heads/master"
]
}
[04:27:53.322] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582777672038185",
"id": "8887331035723042368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2cd0af7ea20547c2471483ef2233f3b068db93c3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582777673005110",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169070",
"builder:Linux Builder (dbg)",
"buildset:commit/git/2cd0af7ea20547c2471483ef2233f3b068db93c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2cd0af7ea20547c2471483ef2233f3b068db93c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052761097920471984",
"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/8887331035723042368/+/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": "1582777673005255",
"url": "https://ci.chromium.org/b/8887331035723042368",
"utcnow_ts": "1582777673308617"
}
}
[04:27:53.323] Task URL: https://ci.chromium.org/b/8887331035723042368
[04:27:53.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:2:0) after 1m0s
[04:28:53.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:2:0)
[04:28:53.406] Timer tick, asking Buildbucket for the build status
[04:28:53.500] Build 8887331035723042368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:53.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:3:0) after 1m0s
[04:29:53.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:3:0)
[04:29:53.678] Timer tick, asking Buildbucket for the build status
[04:29:53.764] Build 8887331035723042368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:53.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:4:0) after 1m0s
[04:30:53.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:4:0)
[04:30:53.774] Timer tick, asking Buildbucket for the build status
[04:30:53.986] Build 8887331035723042368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:53.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:5:0) after 1m0s
[04:31:54.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:5:0)
[04:31:54.052] Timer tick, asking Buildbucket for the build status
[04:31:54.162] Build 8887331035723042368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:54.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:6:0) after 1m0s
[04:32:07.769] Received PubSub notification, asking Buildbucket for the build status
[04:32:07.852] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:54.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:6:0)
[04:32:54.370] Timer tick, asking Buildbucket for the build status
[04:32:54.593] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:54.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:8:0) after 1m0s
[04:33:54.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:8:0)
[04:33:54.748] Timer tick, asking Buildbucket for the build status
[04:33:54.872] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:54.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:9:0) after 1m0s
[04:34:55.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:9:0)
[04:34:55.024] Timer tick, asking Buildbucket for the build status
[04:34:55.149] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:55.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:10:0) after 1m0s
[04:35:55.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:10:0)
[04:35:55.245] Timer tick, asking Buildbucket for the build status
[04:35:55.354] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:55.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:11:0) after 1m0s
[04:36:55.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:11:0)
[04:36:55.518] Timer tick, asking Buildbucket for the build status
[04:36:55.626] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:55.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:12:0) after 1m0s
[04:37:55.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:12:0)
[04:37:55.773] Timer tick, asking Buildbucket for the build status
[04:37:55.896] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:55.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:13:0) after 1m0s
[04:38:55.972] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:13:0)
[04:38:55.972] Timer tick, asking Buildbucket for the build status
[04:38:56.086] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:56.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:14:0) after 1m0s
[04:39:56.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:14:0)
[04:39:56.154] Timer tick, asking Buildbucket for the build status
[04:39:56.325] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:56.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:15:0) after 1m0s
[04:40:56.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:15:0)
[04:40:56.373] Timer tick, asking Buildbucket for the build status
[04:40:56.462] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:56.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:16:0) after 1m0s
[04:41:56.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:16:0)
[04:41:56.569] Timer tick, asking Buildbucket for the build status
[04:41:56.958] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:56.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:17:0) after 1m0s
[04:42:57.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:17:0)
[04:42:57.004] Timer tick, asking Buildbucket for the build status
[04:42:57.096] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:57.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:18:0) after 1m0s
[04:43:57.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:18:0)
[04:43:57.158] Timer tick, asking Buildbucket for the build status
[04:43:57.253] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:57.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:19:0) after 1m0s
[04:44:57.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:19:0)
[04:44:57.280] Timer tick, asking Buildbucket for the build status
[04:44:57.549] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:57.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:20:0) after 1m0s
[04:45:57.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:20:0)
[04:45:57.577] Timer tick, asking Buildbucket for the build status
[04:45:57.774] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:57.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:21:0) after 1m0s
[04:46:57.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:21:0)
[04:46:57.822] Timer tick, asking Buildbucket for the build status
[04:46:58.207] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:58.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:22:0) after 1m0s
[04:47:58.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:22:0)
[04:47:58.242] Timer tick, asking Buildbucket for the build status
[04:47:58.329] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:58.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:23:0) after 1m0s
[04:48:58.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:23:0)
[04:48:58.377] Timer tick, asking Buildbucket for the build status
[04:48:58.583] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:58.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:24:0) after 1m0s
[04:49:58.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:24:0)
[04:49:58.655] Timer tick, asking Buildbucket for the build status
[04:49:58.748] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:58.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:25:0) after 1m0s
[04:50:58.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:25:0)
[04:50:58.804] Timer tick, asking Buildbucket for the build status
[04:50:59.123] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:59.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:26:0) after 1m0s
[04:51:59.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:26:0)
[04:51:59.211] Timer tick, asking Buildbucket for the build status
[04:51:59.487] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:59.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:27:0) after 1m0s
[04:52:59.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:27:0)
[04:52:59.541] Timer tick, asking Buildbucket for the build status
[04:52:59.652] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:59.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:28:0) after 1m0s
[04:53:59.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:28:0)
[04:53:59.682] Timer tick, asking Buildbucket for the build status
[04:53:59.770] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:59.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:29:0) after 1m0s
[04:54:59.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:29:0)
[04:54:59.797] Timer tick, asking Buildbucket for the build status
[04:54:59.912] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:59.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:30:0) after 1m0s
[04:55:59.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:30:0)
[04:55:59.976] Timer tick, asking Buildbucket for the build status
[04:56:00.192] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:00.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:31:0) after 1m0s
[04:57:00.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:31:0)
[04:57:00.231] Timer tick, asking Buildbucket for the build status
[04:57:00.450] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:00.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:32:0) after 1m0s
[04:58:00.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:32:0)
[04:58:00.620] Timer tick, asking Buildbucket for the build status
[04:58:01.779] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:01.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:33:0) after 1m0s
[04:59:01.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:33:0)
[04:59:01.856] Timer tick, asking Buildbucket for the build status
[04:59:02.097] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:02.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:34:0) after 1m0s
[05:00:02.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:34:0)
[05:00:02.280] Timer tick, asking Buildbucket for the build status
[05:00:02.399] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:02.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:35:0) after 1m0s
[05:01:02.438] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:35:0)
[05:01:02.438] Timer tick, asking Buildbucket for the build status
[05:01:02.586] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:02.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:36:0) after 1m0s
[05:02:02.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:36:0)
[05:02:02.642] Timer tick, asking Buildbucket for the build status
[05:02:02.736] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:02.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:37:0) after 1m0s
[05:03:02.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:37:0)
[05:03:02.795] Timer tick, asking Buildbucket for the build status
[05:03:03.103] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:03.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:38:0) after 1m0s
[05:04:03.160] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:38:0)
[05:04:03.160] Timer tick, asking Buildbucket for the build status
[05:04:03.538] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:03.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:39:0) after 1m0s
[05:05:03.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:39:0)
[05:05:03.667] Timer tick, asking Buildbucket for the build status
[05:05:03.781] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:03.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:40:0) after 1m0s
[05:06:03.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:40:0)
[05:06:03.823] Timer tick, asking Buildbucket for the build status
[05:06:03.955] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:03.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:41:0) after 1m0s
[05:07:03.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:41:0)
[05:07:03.979] Timer tick, asking Buildbucket for the build status
[05:07:04.169] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:04.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:42:0) after 1m0s
[05:08:04.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:42:0)
[05:08:04.195] Timer tick, asking Buildbucket for the build status
[05:08:04.447] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:04.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:43:0) after 1m0s
[05:09:04.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:43:0)
[05:09:04.522] Timer tick, asking Buildbucket for the build status
[05:09:04.751] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:04.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:44:0) after 1m0s
[05:10:04.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:44:0)
[05:10:04.812] Timer tick, asking Buildbucket for the build status
[05:10:05.155] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:05.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:45:0) after 1m0s
[05:11:05.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:45:0)
[05:11:05.178] Timer tick, asking Buildbucket for the build status
[05:11:05.267] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:05.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:46:0) after 1m0s
[05:12:05.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:46:0)
[05:12:05.288] Timer tick, asking Buildbucket for the build status
[05:12:05.543] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:05.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:47:0) after 1m0s
[05:13:05.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:47:0)
[05:13:05.580] Timer tick, asking Buildbucket for the build status
[05:13:05.681] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:05.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:48:0) after 1m0s
[05:14:05.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:48:0)
[05:14:05.703] Timer tick, asking Buildbucket for the build status
[05:14:05.848] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:05.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:49:0) after 1m0s
[05:15:05.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:49:0)
[05:15:05.870] Timer tick, asking Buildbucket for the build status
[05:15:06.098] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:06.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:50:0) after 1m0s
[05:16:06.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:50:0)
[05:16:06.128] Timer tick, asking Buildbucket for the build status
[05:16:06.221] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:06.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:51:0) after 1m0s
[05:17:06.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:51:0)
[05:17:06.228] Timer tick, asking Buildbucket for the build status
[05:17:06.320] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:06.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:52:0) after 1m0s
[05:18:06.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:52:0)
[05:18:06.370] Timer tick, asking Buildbucket for the build status
[05:18:06.492] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:06.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:53:0) after 1m0s
[05:19:06.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:53:0)
[05:19:06.484] Timer tick, asking Buildbucket for the build status
[05:19:06.602] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:06.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:54:0) after 1m0s
[05:20:06.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:54:0)
[05:20:06.638] Timer tick, asking Buildbucket for the build status
[05:20:07.002] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:07.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:55:0) after 1m0s
[05:21:07.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:55:0)
[05:21:07.100] Timer tick, asking Buildbucket for the build status
[05:21:07.185] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:07.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:56:0) after 1m0s
[05:22:07.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:56:0)
[05:22:07.239] Timer tick, asking Buildbucket for the build status
[05:22:07.440] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:07.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:57:0) after 1m0s
[05:23:07.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:57:0)
[05:23:07.546] Timer tick, asking Buildbucket for the build status
[05:23:07.640] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:07.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:58:0) after 1m0s
[05:24:07.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:58:0)
[05:24:07.785] Timer tick, asking Buildbucket for the build status
[05:24:07.914] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:07.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:59:0) after 1m0s
[05:25:07.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:59:0)
[05:25:07.985] Timer tick, asking Buildbucket for the build status
[05:25:08.172] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:08.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:60:0) after 1m0s
[05:26:08.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:60:0)
[05:26:08.224] Timer tick, asking Buildbucket for the build status
[05:26:08.351] Build 8887331035723042368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:08.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052761097920471984:61:0) after 1m0s
[05:27:05.196] Received PubSub notification, asking Buildbucket for the build status
[05:27:05.273] Build 8887331035723042368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:27:05.273] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582781224365032",
"created_by": "project:chromium",
"created_ts": "1582777672038185",
"id": "8887331035723042368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2cd0af7ea20547c2471483ef2233f3b068db93c3\"}}",
"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-89-erny\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169070, \"got_angle_revision\": \"0a450363dbdc43bf3350b19493c88482dbc079e3\", \"got_dawn_revision\": \"a9d7d478429d8deaac52a0578826783877cd556a\", \"got_nacl_revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\", \"got_revision\": \"2cd0af7ea20547c2471483ef2233f3b068db93c3\", \"got_revision_cp\": \"refs/heads/master@{#744936}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"4d40271e3f09de5e6734b4223ea15b4faf758d2a\", \"got_v8_revision\": \"60a026a7868f4dde15a744cb2d757b1da67a23d7\", \"got_v8_revision_cp\": \"refs/heads/8.2.196@{#1}\", \"got_webrtc_revision\": \"206d46750780467c78a233949b8b44d04e3ca0d5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30621}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2cd0af7ea20547c2471483ef2233f3b068db93c3\", \"swarm_hashes_refs/heads/master(at){#744936}_without_patch\": {\"accessibility_unittests\": \"05236d55f2a2e788813d4224203c25b63e393fc6\", \"angle_unittests\": \"7cd68793119c4f6b26364154ba1ae8dce22d9593\", \"app_shell_unittests\": \"7311c274da76fa00f28ec114005c5185d55294d0\", \"aura_unittests\": \"50a1a1b5815899bbdb0d0ebbd9c83a0387786c71\", \"base_unittests\": \"f2691804e8e6a767df4f23a7256302bf590f9480\", \"base_util_unittests\": \"051dabf8dbf701695f13aeaf803ca75ec3afa0de\", \"blink_common_unittests\": \"3fd119fd4800b0cfcb94ffdcecc345b0167bf797\", \"blink_fuzzer_unittests\": \"63f38c528310a2bae8e31c7c1ee534d4f8b33227\", \"blink_heap_unittests\": \"2c9a1a5f1c04c08c7e9fd9b3949267290fe7fb39\", \"blink_platform_unittests\": \"f7616476867da20b28e1167139efaccfcbf5f4af\", \"blink_python_tests\": \"a8e99a76b1cee3e7b27ae91866202461e074a8c5\", \"blink_unittests\": \"e4b3c1350479c1881cb8caed10d09d8b2eb16606\", \"blink_web_tests\": \"df79dd4c6f581ee8fe94fd0d708073ef84c03284\", \"boringssl_crypto_tests\": \"4d1ba9aad8b67ad5047522f0f32f12fae68633b1\", \"boringssl_ssl_tests\": \"55fc21375273d2ecff5c30a173f60492ebfe4320\", \"browser_tests\": \"f3615986e7df2d7c860ca2a6f0cb3ede6b5bfcd8\", \"cacheinvalidation_unittests\": \"6b11b93cc3313d9db52df3ae6d34006ec23f35f2\", \"capture_unittests\": \"d1391e255aeb262c82fb5b6d62ee0a61aaece97c\", \"cast_unittests\": \"939643810f2069cf20bc53a4b459a7a0e6f50351\", \"cc_unittests\": \"f25893985dc1ef3cef0ee90159d1d62c2d8228df\", \"chrome_app_unittests\": \"2e04015043493584e9b73dbbca1eeed741aee3a0\", \"chromedriver_unittests\": \"376cf94c1e2a643d8f96f2d9bb3c5473eb58a03a\", \"components_browsertests\": \"9ffd60078aa795d5b1b0f56754148d53ea283a15\", \"components_unittests\": \"865681a9ab558244039c5c9c8ba15e910e1d854c\", \"compositor_unittests\": \"9ed7b2fc7c2d8bd71a6ba5ea5e896e98e2935652\", \"content_browsertests\": \"fc8645c5609a05e2fc8d6fd022c75492c81bd024\", \"content_shell_crash_test\": \"8c55bac068a23ada08150720c6d83dbc8ccb9e39\", \"content_unittests\": \"61d96c9ff75d8861c857d42347ba8d19241db2b6\", \"crashpad_tests\": \"eeaa9737d7feb869471a7e9c5358d661d2ee9289\", \"cronet_tests\": \"aaa309af2685be95bd48e3472b2974d6560674a2\", \"cronet_unittests\": \"981e3520e31d4d678cd55e5bd2c9d68a821ef5bb\", \"crypto_unittests\": \"e8f9e4da66ee8b600559765f5664fbb09c265c79\", \"dbus_unittests\": \"0651a62acf65e92f6cfb0a436f5fa92a9a88e4cc\", \"device_unittests\": \"12e9971c221a0a270f36c501f9c269572cde3d66\", \"display_unittests\": \"5730248466972b10202e48d5a4c9af2fe6a1c5ed\", \"events_unittests\": \"80a0219ffd8a4261e937564a252a5dfcf607204a\", \"extensions_browsertests\": \"b8472df67f62e75f43b7a3a817362e076e941441\", \"extensions_unittests\": \"7116f763eb8a6ece35226d9d273ecb53ab8f4522\", \"filesystem_service_unittests\": \"d61193def1feaca3ff44c16994adc011e7122c7f\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"046b4b187194a781888887d3f490b3567b4659d5\", \"gfx_unittests\": \"6350c32e7c8ba446b06a49a8920009c1ad1df3a5\", \"gin_unittests\": \"1daae8afabfcb265270b969b74543962af8e5c38\", \"google_apis_unittests\": \"b809bb29c1c55aeaacb0473a08703fa22776307e\", \"gpu_unittests\": \"c439ff81aaeb9f5a65119f47278dffb1518a84c9\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"8aa9a3bdc651c35dc98c57dee16e323a1734d759\", \"headless_browsertests\": \"888340a3d084d3d85af937c711c7dec62639da42\", \"headless_unittests\": \"84112fc39eaa37c16e81fe3360f2ac753c76e4d8\", \"interactive_ui_tests\": \"4fc3d42095b80ac49f358972e698e1877c6812cc\", \"ipc_tests\": \"b8fa3cf0d0c900cdb2d8a5b7097e86e653eff85a\", \"jingle_unittests\": \"54322b0cf541b87862a4c1382dc2f32dd324e7f8\", \"latency_unittests\": \"b797168309d531dd9bf6b3ec437505ea615d2b29\", \"libjingle_xmpp_unittests\": \"1f4ec14ecb44b9d3594caa44b349c5ec39b286f0\", \"media_blink_unittests\": \"fc2194391b0970b95830288646f8aba047fff414\", \"media_service_unittests\": \"c729b652d83436b66b12ee3dc164dbaf8abbfc22\", \"media_unittests\": \"3cc69bbbe20b6d2ab4bcd8be87acbf938f40c6df\", \"message_center_unittests\": \"5d0c1dce8742d02acc54e2025b03a8a94d299559\", \"metrics_python_tests\": \"901d687f7c1405b18a2bf20579b1a7372458aad0\", \"midi_unittests\": \"7e1265163a257190337effd2d71d1cf22940621c\", \"mojo_core_unittests\": \"48608057ecb7a6fb3cbc961a40a7552ec6a772c9\", \"mojo_unittests\": \"d586864c4a54ee23e9105da18ffa6a7d4de728de\", \"nacl_helper_nonsfi_unittests\": \"4476743a88e8279080643a99261ce632ba9984c8\", \"nacl_loader_unittests\": \"21221b5f0104735410f630cf3c9d9917a253fbf9\", \"native_theme_unittests\": \"78f0966d5f0ed112040517321815f11d49782b28\", \"net_unittests\": \"3fe4f1e591aef6481d4ab9d2e2b8a264e54573c4\", \"pdf_unittests\": \"9586b9caa15dbf87366a7da32d5f3fd1084ce107\", \"perfetto_unittests\": \"2dab47f8972747993161ad440782e25ec15cb9e4\", \"ppapi_unittests\": \"d576fc8e07a54995d52c7894f678a6d1417ee9cd\", \"printing_unittests\": \"f6ed29aa6febdd7a8a41da3bad3e95a3b9cb744e\", \"remoting_unittests\": \"341613d4ca36588ea46b9d98fb097c3c5df2acb0\", \"sandbox_linux_unittests\": \"8fb5dc3665c177042fc2c3ee10f7da094d5d923b\", \"service_manager_unittests\": \"8614f37ad44429724aac472d9a5e85f3ca789a22\", \"services_unittests\": \"7d98bc21d61dde6298b5c57b6c6ad70b24582b73\", \"shell_dialogs_unittests\": \"7edc316b39d213cb16ef93296f8d83675fec7018\", \"skia_unittests\": \"b45330286d27f547e0fc8eb79d8d72e9df93095c\", \"snapshot_unittests\": \"99a2c372e83875ec0443535f6b5abbddc10cb3ae\", \"sql_unittests\": \"a7cfb4ba9121f4124409cbb209812b0566cdd267\", \"storage_unittests\": \"5f4df4057efb425b118cbeebba5363c266cc1059\", \"sync_integration_tests\": \"1f891734df59fc41c608b40c363cc5e7a7fff28e\", \"telemetry_gpu_unittests\": \"ef5cb9d0eee5f7b151dc48678b24df8eea25eadb\", \"telemetry_perf_unittests\": \"bcfed5cf46aa8a022c5784f464d47a5f67330117\", \"telemetry_unittests\": \"16043ecb4bdd835c55fdc46d02bc40faa96c0496\", \"traffic_annotation_auditor_unittests\": \"2449cd4e4a8bd6917fdf432556b4b2d48589307b\", \"ui_base_unittests\": \"20286f1958b7b54358f8b9db1b4c23e25bff6b16\", \"ui_touch_selection_unittests\": \"15ba327b903aaa21ad2d530ba8262d4093b959fd\", \"unit_tests\": \"5de7beded1935eb9555ec751dfec06bfcf6adbc9\", \"url_unittests\": \"b9cd74c2341fd79c6ed493740c38aff4cbe62675\", \"views_perftests\": \"bb7392b4e66e44e469e98e06571a4706123ef309\", \"views_unittests\": \"6b50250773652555f3eb2da34cc71828f57fdd27\", \"viz_unittests\": \"3d44f01aa304f21e9e71159b6eaa6aadaf2d868e\", \"vr_common_unittests\": \"4a8eda444e8e1e01a85bc5c38ca87e7beffaf472\", \"vr_pixeltests\": \"774c361a3d5ee65819addb4efcdeb70b9819912f\", \"webdriver_wpt_tests\": \"ea9c4d1bd96f64e07079f85f53d3b8947ecb56f3\", \"weblayer_browsertests\": \"f4dab42dc243081e448677d0237babc81b741797\", \"wm_unittests\": \"cb53a36da080bea164d86d049d90c69fd3b7f645\", \"wtf_unittests\": \"842ac0288d07ac44f6815f94a50fae73f4349677\", \"xr_browser_tests\": \"5c8e77cb4deb1db2657d402dbd4b9b6530ba73e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_49b2c59a41dab71fb2bba5f6f8a4efb56888b0948fbb2a1ad8fa728b25e0dc17_v2\", \"builder_7a9f94695aa83f7478015e01762e75301e67c95c681ec0592232bd343861e191_v2\", \"builder_b113f2ba74b645396d20a53e30fea3b3f4dbe0717301c9938984732251717657_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-89-erny\"], \"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\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582777926989460",
"status": "COMPLETED",
"status_changed_ts": "1582781224735459",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169070",
"builder:Linux Builder (dbg)",
"buildset:commit/git/2cd0af7ea20547c2471483ef2233f3b068db93c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2cd0af7ea20547c2471483ef2233f3b068db93c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052761097920471984",
"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/8887331035723042368/+/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:4a9db837aabacc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582781224743376",
"url": "https://ci.chromium.org/b/8887331035723042368",
"utcnow_ts": "1582781225263374"
}
}
[05:27:05.273] Invocation finished in 59m14.714293826s with status SUCCEEDED