[18:57:28.321] New invocation is queued and will start shortly
[18:57:29.559] Starting the invocation (attempt 1)
[18:57:29.615] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:57:29.615] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:57:29.615] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059591755037317200",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"24037b7c22488731722027ffde038d2b259a6439\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059591755037317200",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/24037b7c22488731722027ffde038d2b259a6439",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24037b7c22488731722027ffde038d2b259a6439",
"gitiles_ref:refs/heads/master"
]
}
[18:57:30.738] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576263450001667",
"id": "8894161692609942368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24037b7c22488731722027ffde038d2b259a6439\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576263450544622",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166055",
"builder:Linux Builder (dbg)",
"buildset:commit/git/24037b7c22488731722027ffde038d2b259a6439",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24037b7c22488731722027ffde038d2b259a6439",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059591755037317200",
"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/8894161692609942368/+/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": "1576263450544725",
"url": "https://ci.chromium.org/b/8894161692609942368",
"utcnow_ts": "1576263450726156"
}
}
[18:57:30.739] Task URL: https://ci.chromium.org/b/8894161692609942368
[18:57:30.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:2:0) after 1m0s
[18:58:30.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:2:0)
[18:58:30.802] Timer tick, asking Buildbucket for the build status
[18:58:31.134] Build 8894161692609942368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:31.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:3:0) after 1m0s
[18:59:31.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:3:0)
[18:59:31.193] Timer tick, asking Buildbucket for the build status
[18:59:31.519] Build 8894161692609942368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:31.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:4:0) after 1m0s
[19:00:31.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:4:0)
[19:00:31.592] Timer tick, asking Buildbucket for the build status
[19:00:31.798] Build 8894161692609942368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:31.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:5:0) after 1m0s
[19:01:31.797] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:5:0)
[19:01:31.797] Timer tick, asking Buildbucket for the build status
[19:01:32.732] Build 8894161692609942368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:32.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:6:0) after 1m0s
[19:02:16.579] Received PubSub notification, asking Buildbucket for the build status
[19:02:17.302] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:32.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:6:0)
[19:02:32.741] Timer tick, asking Buildbucket for the build status
[19:02:32.906] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:32.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:8:0) after 1m0s
[19:03:32.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:8:0)
[19:03:32.910] Timer tick, asking Buildbucket for the build status
[19:03:33.135] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:33.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:9:0) after 1m0s
[19:04:33.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:9:0)
[19:04:33.165] Timer tick, asking Buildbucket for the build status
[19:04:33.546] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:33.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:10:0) after 1m0s
[19:05:33.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:10:0)
[19:05:33.608] Timer tick, asking Buildbucket for the build status
[19:05:33.821] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:33.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:11:0) after 1m0s
[19:06:33.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:11:0)
[19:06:33.855] Timer tick, asking Buildbucket for the build status
[19:06:34.798] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:34.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:12:0) after 1m0s
[19:07:34.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:12:0)
[19:07:34.825] Timer tick, asking Buildbucket for the build status
[19:07:35.643] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:35.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:13:0) after 1m0s
[19:08:35.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:13:0)
[19:08:35.688] Timer tick, asking Buildbucket for the build status
[19:08:36.603] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:36.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:14:0) after 1m0s
[19:09:36.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:14:0)
[19:09:36.620] Timer tick, asking Buildbucket for the build status
[19:09:37.576] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:37.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:15:0) after 1m0s
[19:10:37.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:15:0)
[19:10:37.685] Timer tick, asking Buildbucket for the build status
[19:10:37.827] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:37.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:16:0) after 1m0s
[19:11:37.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:16:0)
[19:11:37.864] Timer tick, asking Buildbucket for the build status
[19:11:38.245] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:17:0) after 1m0s
[19:12:38.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:17:0)
[19:12:38.264] Timer tick, asking Buildbucket for the build status
[19:12:39.259] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:39.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:18:0) after 1m0s
[19:13:39.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:18:0)
[19:13:39.281] Timer tick, asking Buildbucket for the build status
[19:13:39.535] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:39.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:19:0) after 1m0s
[19:14:39.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:19:0)
[19:14:39.534] Timer tick, asking Buildbucket for the build status
[19:14:40.966] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:40.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:20:0) after 1m0s
[19:15:41.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:20:0)
[19:15:41.049] Timer tick, asking Buildbucket for the build status
[19:15:41.265] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:41.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:21:0) after 1m0s
[19:16:41.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:21:0)
[19:16:41.366] Timer tick, asking Buildbucket for the build status
[19:16:41.601] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:41.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:22:0) after 1m0s
[19:17:41.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:22:0)
[19:17:41.705] Timer tick, asking Buildbucket for the build status
[19:17:42.088] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:42.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:23:0) after 1m0s
[19:18:42.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:23:0)
[19:18:42.107] Timer tick, asking Buildbucket for the build status
[19:18:42.375] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:42.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:24:0) after 1m0s
[19:19:42.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:24:0)
[19:19:42.436] Timer tick, asking Buildbucket for the build status
[19:19:42.703] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:42.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:25:0) after 1m0s
[19:20:42.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:25:0)
[19:20:42.709] Timer tick, asking Buildbucket for the build status
[19:20:43.274] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:43.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:26:0) after 1m0s
[19:21:43.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:26:0)
[19:21:43.351] Timer tick, asking Buildbucket for the build status
[19:21:43.563] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:43.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:27:0) after 1m0s
[19:22:43.636] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:27:0)
[19:22:43.636] Timer tick, asking Buildbucket for the build status
[19:22:44.284] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:44.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:28:0) after 1m0s
[19:23:44.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:28:0)
[19:23:44.329] Timer tick, asking Buildbucket for the build status
[19:23:44.526] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:44.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:29:0) after 1m0s
[19:24:44.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:29:0)
[19:24:44.554] Timer tick, asking Buildbucket for the build status
[19:24:45.943] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:45.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:30:0) after 1m0s
[19:25:46.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:30:0)
[19:25:46.158] Timer tick, asking Buildbucket for the build status
[19:25:46.680] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:46.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:31:0) after 1m0s
[19:26:46.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:31:0)
[19:26:46.865] Timer tick, asking Buildbucket for the build status
[19:26:47.062] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:47.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:32:0) after 1m0s
[19:27:47.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:32:0)
[19:27:47.149] Timer tick, asking Buildbucket for the build status
[19:27:47.424] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:47.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:33:0) after 1m0s
[19:28:47.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:33:0)
[19:28:47.442] Timer tick, asking Buildbucket for the build status
[19:28:47.645] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:47.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:34:0) after 1m0s
[19:29:47.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:34:0)
[19:29:47.756] Timer tick, asking Buildbucket for the build status
[19:29:48.947] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:48.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:35:0) after 1m0s
[19:30:49.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:35:0)
[19:30:49.133] Timer tick, asking Buildbucket for the build status
[19:30:49.761] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:49.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:36:0) after 1m0s
[19:31:49.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:36:0)
[19:31:49.809] Timer tick, asking Buildbucket for the build status
[19:31:49.966] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:49.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:37:0) after 1m0s
[19:32:50.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:37:0)
[19:32:50.116] Timer tick, asking Buildbucket for the build status
[19:32:50.820] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:50.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:38:0) after 1m0s
[19:33:50.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:38:0)
[19:33:50.956] Timer tick, asking Buildbucket for the build status
[19:33:51.197] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:51.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:39:0) after 1m0s
[19:34:51.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:39:0)
[19:34:51.463] Timer tick, asking Buildbucket for the build status
[19:34:51.822] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:51.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:40:0) after 1m0s
[19:35:51.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:40:0)
[19:35:51.879] Timer tick, asking Buildbucket for the build status
[19:35:52.497] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:52.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:41:0) after 1m0s
[19:36:52.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:41:0)
[19:36:52.547] Timer tick, asking Buildbucket for the build status
[19:36:52.814] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:52.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:42:0) after 1m0s
[19:37:52.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:42:0)
[19:37:52.899] Timer tick, asking Buildbucket for the build status
[19:37:53.082] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:53.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:43:0) after 1m0s
[19:38:53.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:43:0)
[19:38:53.115] Timer tick, asking Buildbucket for the build status
[19:38:53.281] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:53.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:44:0) after 1m0s
[19:39:53.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:44:0)
[19:39:53.445] Timer tick, asking Buildbucket for the build status
[19:39:54.884] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:54.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:45:0) after 1m0s
[19:40:54.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:45:0)
[19:40:54.998] Timer tick, asking Buildbucket for the build status
[19:40:56.466] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:56.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:46:0) after 1m0s
[19:41:56.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:46:0)
[19:41:56.599] Timer tick, asking Buildbucket for the build status
[19:41:57.083] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:57.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:47:0) after 1m0s
[19:42:57.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:47:0)
[19:42:57.247] Timer tick, asking Buildbucket for the build status
[19:42:57.890] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:57.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:48:0) after 1m0s
[19:43:57.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:48:0)
[19:43:57.953] Timer tick, asking Buildbucket for the build status
[19:43:58.962] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:58.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:49:0) after 1m0s
[19:44:59.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:49:0)
[19:44:59.116] Timer tick, asking Buildbucket for the build status
[19:44:59.341] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:59.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:50:0) after 1m0s
[19:45:59.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:50:0)
[19:45:59.474] Timer tick, asking Buildbucket for the build status
[19:45:59.636] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:51:0) after 1m0s
[19:46:59.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:51:0)
[19:46:59.780] Timer tick, asking Buildbucket for the build status
[19:47:00.305] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:00.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:52:0) after 1m0s
[19:48:00.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:52:0)
[19:48:00.668] Timer tick, asking Buildbucket for the build status
[19:48:01.361] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:01.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:53:0) after 1m0s
[19:49:01.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:53:0)
[19:49:01.532] Timer tick, asking Buildbucket for the build status
[19:49:02.433] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:02.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:54:0) after 1m0s
[19:50:02.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:54:0)
[19:50:02.968] Timer tick, asking Buildbucket for the build status
[19:50:03.177] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:03.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:55:0) after 1m0s
[19:51:03.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:55:0)
[19:51:03.197] Timer tick, asking Buildbucket for the build status
[19:51:04.179] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:04.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:56:0) after 1m0s
[19:52:04.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:56:0)
[19:52:04.253] Timer tick, asking Buildbucket for the build status
[19:52:04.619] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:04.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:57:0) after 1m0s
[19:53:04.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:57:0)
[19:53:04.802] Timer tick, asking Buildbucket for the build status
[19:53:05.837] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:05.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:58:0) after 1m0s
[19:54:05.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:58:0)
[19:54:05.824] Timer tick, asking Buildbucket for the build status
[19:54:06.505] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:06.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:59:0) after 1m0s
[19:55:06.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:59:0)
[19:55:06.566] Timer tick, asking Buildbucket for the build status
[19:55:06.771] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:06.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:60:0) after 1m0s
[19:56:06.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:60:0)
[19:56:06.876] Timer tick, asking Buildbucket for the build status
[19:56:07.247] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:07.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:61:0) after 1m0s
[19:57:07.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:61:0)
[19:57:07.304] Timer tick, asking Buildbucket for the build status
[19:57:07.570] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:07.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:62:0) after 1m0s
[19:58:07.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:62:0)
[19:58:07.663] Timer tick, asking Buildbucket for the build status
[19:58:09.656] Build 8894161692609942368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:09.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059591755037317200:63:0) after 1m0s
[19:58:37.447] Received PubSub notification, asking Buildbucket for the build status
[19:58:37.798] Build 8894161692609942368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:58:37.798] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576267116696806",
"created_by": "project:chromium",
"created_ts": "1576263450001667",
"id": "8894161692609942368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24037b7c22488731722027ffde038d2b259a6439\"}}",
"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-central1-b-8-120-agdo\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166055, \"got_angle_revision\": \"e1822727560b6eb2e65ae9d41f6032923a7a6663\", \"got_dawn_revision\": \"77fd4750ae5ad3ee9f281089fddfeaca56ed049c\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"24037b7c22488731722027ffde038d2b259a6439\", \"got_revision_cp\": \"refs/heads/master@{#724711}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"468ee1576da76a2d6b6e4861d9a874944ab7b959\", \"got_v8_revision\": \"785b7f0be4c8a228eb4072fdbb0105cbf05620de\", \"got_v8_revision_cp\": \"refs/heads/8.1.32@{#1}\", \"got_webrtc_revision\": \"41466b7bef5aa0927e3724f53c556bc4019f80d4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30087}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24037b7c22488731722027ffde038d2b259a6439\", \"swarm_hashes_refs/heads/master(at){#724711}_without_patch\": {\"accessibility_unittests\": \"be3e4bc5bea3bcbeacec609b895fb102806ba928\", \"angle_unittests\": \"2996c4360fe1564daba92b2bc31c95eaaa5022d2\", \"app_shell_unittests\": \"2e509232715ae5ec44b6d3bddc5397c37a23d3ad\", \"aura_unittests\": \"5b80faebb5704842a281f21eec0996ee7118e2d6\", \"base_unittests\": \"62a37f9c90564e0f9a1c02cb60f1fd2fd779295a\", \"base_util_unittests\": \"5c5a4a37861a68c5368d60f5c39fb839480c4640\", \"blink_common_unittests\": \"aea7e1e8766c6c2beb3da7ababf6a9940364f7aa\", \"blink_fuzzer_unittests\": \"81209469e542d8806907e6b5458dff08c6d05905\", \"blink_heap_unittests\": \"c6f2fafcd1d2520f0664c0a19d59afdfbab1d5db\", \"blink_platform_unittests\": \"b41c1001b799eeba2ae15ab80d9fa096f6066031\", \"blink_python_tests\": \"d82713f5b3a98a41ecd62cc3a2e1013ccf1bca85\", \"blink_unittests\": \"2ca9002a75f8f916ec98dd4be21b3dc39d6ae303\", \"blink_web_tests\": \"bf3a54d9963b8c9a418a3127d0e9de49c54be909\", \"boringssl_crypto_tests\": \"e67155d51c588bbd3aa75a0d7f3529a6f1eb6871\", \"boringssl_ssl_tests\": \"8a0b0f3bbcfdb04c0f6e77105dc5b4bb115f3135\", \"browser_tests\": \"08e5f1efaaafec3dcf9725c8b0429dbf7318f35d\", \"cacheinvalidation_unittests\": \"828a105ad04d719f56e47e1d2a60a476281ccb0b\", \"capture_unittests\": \"0e6d9d4264c0a3d303dea960be87b99fb733ba55\", \"cast_unittests\": \"35527e2c50638e20b27aa4047ca69b751b18e504\", \"cc_unittests\": \"5f668237aee2aaf1c54672ea737887742b4e10c2\", \"chrome_app_unittests\": \"072fa5cb7c032242dd0919adadc1ae660459d631\", \"chromedriver_unittests\": \"1c455f132af6142b7c8e2f56a578de1c2677a495\", \"components_browsertests\": \"6512456353dd5f01c5b6690ff87f7fecb363bbab\", \"components_unittests\": \"055777bb701a0461b471d9535fe79bdf1e24b973\", \"compositor_unittests\": \"5bb74165649d8b27d306a5129cec627458a6ab1d\", \"content_browsertests\": \"f829216fe90855c7899b37fc86b01777988d5f12\", \"content_shell_crash_test\": \"73b998b8ee675726a35132c4ee523fd1468fda2a\", \"content_unittests\": \"5b57d709358930e97215421abd4df06c7e566f40\", \"crashpad_tests\": \"79b5568b94c9e68315f440472469686ec6cec5a8\", \"cronet_tests\": \"0c10dfb3870983d18f84d5b268280cef6a05f6a3\", \"cronet_unittests\": \"21ba5f2de6cedafbbe5d318796ee95d6c59faded\", \"crypto_unittests\": \"0633404b02b62f61cfaa06967f4b62c11c1b3a7a\", \"dbus_unittests\": \"d1fd1a7855a6ef9aa3222ccf9786124dcdeb4a36\", \"device_unittests\": \"d150f72a3e7408b11cac7e2e7dcbae7b97e94ab4\", \"devtools_lint_check\": \"1bf2f108f8410c21e2a04749bd05c0eb49e79b0e\", \"devtools_type_check\": \"d1c26d88e2a8ccfac08e83823baf80cce4317e5c\", \"display_unittests\": \"02ca1dc5f7450a932bb98832416cf61e44d2b559\", \"events_unittests\": \"2103eca2dfe7a928c8aa6e8c0ab0cbc85f7bcf54\", \"extensions_browsertests\": \"ea544a1ebe77f9d74e781833261a0e590facffbf\", \"extensions_unittests\": \"f613bb28fa47eb74a169c5eb227f37d127738cd2\", \"filesystem_service_unittests\": \"55d740db9ffda515258e656a262a03c7f48e5869\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"5310e7961d4e856db8a3184d82cbe12d5d98507c\", \"gfx_unittests\": \"bb764778beb29f5a5ddcec8832af8d8161bad86b\", \"gin_unittests\": \"4d01cd875543a8956d52ba51836cc36a578cf50f\", \"google_apis_unittests\": \"bc4c7bb486cda16b772e2dba4694b9f00bdc1f03\", \"gpu_unittests\": \"7ec1dcac9d7408ced891ff553f6e922db8c8790e\", \"grit_python_unittests\": \"25dff9ef6327c596609d376409bc1d0e605b6d43\", \"gwp_asan_unittests\": \"08edd1dc800d1af3705331577a173d9aa60fba7f\", \"headless_browsertests\": \"fc20a4040d419b7d67caa5fe6c194bcaab066aa4\", \"headless_unittests\": \"d7fd9ee2f71ee315a85659ad2da751899c9acd99\", \"interactive_ui_tests\": \"0a8399b72706afb15679f3cfa78b7baa78a33f47\", \"ipc_tests\": \"1494995cba926ae22e98c764916ad431e3972237\", \"jingle_unittests\": \"fdf418f75b2631bc9b1658aa4ee6f53e3c2e4699\", \"latency_unittests\": \"c03ee80f32f893e20319dcb0b622ceb39fba2517\", \"libjingle_xmpp_unittests\": \"216282c1a71a9daf62aa181d3d986cb62d83baa4\", \"media_blink_unittests\": \"2577c4fa896658155d3713ca5bdc7387e4438a4a\", \"media_service_unittests\": \"f5bbfc04ec99f1c5922b8d88b4613104a096fdad\", \"media_unittests\": \"c09766b1e1ce13e17380706ce8fbd9c4fd5fdef3\", \"message_center_unittests\": \"e21970c785858f68f106ca2cdb1129b9e0ca7843\", \"metrics_python_tests\": \"97f239d6bef84ba1049723e4012fc12380363808\", \"midi_unittests\": \"9c562f8734d0576cd3c1dcf2f72134634329ab1e\", \"mojo_core_unittests\": \"e31c83ec714b35637aaff43d6c1e9f816a536486\", \"mojo_unittests\": \"165cb603cdc358486e3ee55c3ab78a01d0c3ee1a\", \"nacl_helper_nonsfi_unittests\": \"a6a55acb2d8bb44db90ae483beb729483da87550\", \"nacl_loader_unittests\": \"48e6e55a215564322a23f3f0de8a4edd2444174a\", \"native_theme_unittests\": \"f2b27db9c8c5002a4beb3f55858e0c46e0a9e428\", \"net_unittests\": \"6bb18d4bf6dd02d4604d61faab0eabfa47571dd2\", \"pdf_unittests\": \"05f50a1a13cc49f3a558e0ba706bb11a5b9622c0\", \"perfetto_unittests\": \"c1f4d8ee4eac812aa744de02f0bf72d96e8f001a\", \"ppapi_unittests\": \"364a6d7c88e38f5be5ac6f5db0e9bc3f263e4c73\", \"printing_unittests\": \"4e4233466b19371e435f566c437c56a9a482bac1\", \"remoting_unittests\": \"b76a1bd51c3a14db265bbc50f2a3d448a3804d9a\", \"sandbox_linux_unittests\": \"e256da7aa667c2534642fa52b91f00cfc7eb0400\", \"service_manager_unittests\": \"c5cc0a562084a8d01ccb3df0b9bdaedaf9297dc0\", \"services_unittests\": \"6da8e6eac2db5252ed41a04c727867b661a8acb5\", \"shell_dialogs_unittests\": \"a22002259c7c8540165ff079917c4e1798deb8b7\", \"skia_unittests\": \"7ebfe923ebc34ab469f7bdcf9693c0eb85d53133\", \"snapshot_unittests\": \"cf55125bb634a342138c532d4a2d905547b8a0b4\", \"sql_unittests\": \"e8b55a5acda6b0786d9160ed00ad8c8df669b92f\", \"storage_unittests\": \"eb9f986100ff08a053d0c237c3129a97c87a1f88\", \"sync_integration_tests\": \"d96c3cc3190e9709435c1c31d86c0c8620de4d39\", \"telemetry_gpu_unittests\": \"4037dbb6e908cb42615ddc48a69d1447c411c030\", \"telemetry_perf_unittests\": \"6e527d0d77a00afef77c6a78126539d987085d24\", \"telemetry_unittests\": \"1fc7576452ec4768c74d51d7b8e2552c202d9c0a\", \"traffic_annotation_auditor_unittests\": \"aebc834f6e6965a8e78429b042bcc658d10d6b61\", \"ui_base_unittests\": \"5cff398b729615aaedae17bb5079c08dd8dd1fc9\", \"ui_touch_selection_unittests\": \"b2058ae51019b379518d0d5b84b21ee05c6389d7\", \"unit_tests\": \"2d68b11e089cffcd3da831c92ac6759c401c4caf\", \"url_unittests\": \"8ad11f448a82e8fd6fabbcfea550d58f241d1a92\", \"views_perftests\": \"b0808f6431781f3769b781584847d337ae556c5a\", \"views_unittests\": \"3b55ff6b117abfe69eab8069f94143cfe3221975\", \"viz_unittests\": \"b89664805a556102e47726d9ded2adb35edc9a7c\", \"vr_common_unittests\": \"81e6a2acbb066309c2e5cef6e61d87ed0a29a04b\", \"vr_pixeltests\": \"fa20bae4100fd6b8b8889e99ab13c2e117adf70b\", \"webdriver_wpt_tests\": \"6452d2296cfca9e4eb0c60e74525b5c32a28bc4f\", \"weblayer_browsertests\": \"7c773fd3e042b2d454dc994013d38a8e8c32bb03\", \"wm_unittests\": \"80f31666f18f77db010feeb138ba8ea16d7f2b60\", \"wtf_unittests\": \"0c7364d5563a86fa3324f2bbf654152bd2996b8f\", \"xr_browser_tests\": \"2b0bbd8d7a3eb4e7f1ccbeae8504aaadabf983a9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_eb75bb97ad9a82e6e51bc242be3605b13562b7c1ffaba99d94159b9b70e03009_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-central1-b-8-120-agdo\"], \"image\": [\"chrome-xenial-19120100-f3a09baa543\"], \"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\": [\"4724-8894a57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576263735515598",
"status": "COMPLETED",
"status_changed_ts": "1576267116979848",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166055",
"builder:Linux Builder (dbg)",
"buildset:commit/git/24037b7c22488731722027ffde038d2b259a6439",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24037b7c22488731722027ffde038d2b259a6439",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059591755037317200",
"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/8894161692609942368/+/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:4919711b8bdf2810",
"user_agent:luci-scheduler"
],
"updated_ts": "1576267116984547",
"url": "https://ci.chromium.org/b/8894161692609942368",
"utcnow_ts": "1576267117774444"
}
}
[19:58:37.798] Invocation finished in 1h1m9.495807498s with status SUCCEEDED