[02:29:34.610] New invocation is queued and will start shortly
[02:29:35.658] Starting the invocation (attempt 1)
[02:29:35.700] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:29:35.700] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:29:35.700] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018522885280659360",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"22484832339af70186f4b4b277680a568dfe6dce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018522885280659360",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/22484832339af70186f4b4b277680a568dfe6dce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22484832339af70186f4b4b277680a568dfe6dce",
"gitiles_ref:refs/heads/master"
]
}
[02:29:36.430] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615429775831401",
"id": "8853092823336156672",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22484832339af70186f4b4b277680a568dfe6dce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615429776196459",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181287",
"builder:Linux Builder (dbg)",
"buildset:commit/git/22484832339af70186f4b4b277680a568dfe6dce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22484832339af70186f4b4b277680a568dfe6dce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018522885280659360",
"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/8853092823336156672/+/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": "1615429776196603",
"url": "https://ci.chromium.org/b/8853092823336156672",
"utcnow_ts": "1615429776422053"
}
}
[02:29:36.430] Task URL: https://ci.chromium.org/b/8853092823336156672
[02:29:36.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:2:0) after 1m0s
[02:29:47.230] Received PubSub notification, asking Buildbucket for the build status
[02:29:47.514] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:36.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:2:0)
[02:30:36.449] Timer tick, asking Buildbucket for the build status
[02:30:36.708] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:36.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:4:0) after 1m0s
[02:31:36.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:4:0)
[02:31:36.834] Timer tick, asking Buildbucket for the build status
[02:31:37.179] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:37.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:5:0) after 1m0s
[02:32:37.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:5:0)
[02:32:37.219] Timer tick, asking Buildbucket for the build status
[02:32:37.366] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:37.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:6:0) after 1m0s
[02:33:37.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:6:0)
[02:33:37.434] Timer tick, asking Buildbucket for the build status
[02:33:37.529] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:37.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:7:0) after 1m0s
[02:34:37.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:7:0)
[02:34:37.579] Timer tick, asking Buildbucket for the build status
[02:34:37.665] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:37.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:8:0) after 1m0s
[02:35:37.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:8:0)
[02:35:37.698] Timer tick, asking Buildbucket for the build status
[02:35:37.815] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:37.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:9:0) after 1m0s
[02:36:37.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:9:0)
[02:36:37.815] Timer tick, asking Buildbucket for the build status
[02:36:37.905] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:37.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:10:0) after 1m0s
[02:37:37.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:10:0)
[02:37:37.970] Timer tick, asking Buildbucket for the build status
[02:37:38.067] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:38.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:11:0) after 1m0s
[02:38:38.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:11:0)
[02:38:38.140] Timer tick, asking Buildbucket for the build status
[02:38:38.239] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:38.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:12:0) after 1m0s
[02:39:38.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:12:0)
[02:39:38.264] Timer tick, asking Buildbucket for the build status
[02:39:38.346] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:38.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:13:0) after 1m0s
[02:40:38.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:13:0)
[02:40:38.563] Timer tick, asking Buildbucket for the build status
[02:40:38.796] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:38.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:14:0) after 1m0s
[02:41:38.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:14:0)
[02:41:38.896] Timer tick, asking Buildbucket for the build status
[02:41:39.004] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:39.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:15:0) after 1m0s
[02:42:39.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:15:0)
[02:42:39.302] Timer tick, asking Buildbucket for the build status
[02:42:39.441] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:39.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:16:0) after 1m0s
[02:43:39.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:16:0)
[02:43:39.586] Timer tick, asking Buildbucket for the build status
[02:43:39.808] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:39.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:17:0) after 1m0s
[02:44:40.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:17:0)
[02:44:40.054] Timer tick, asking Buildbucket for the build status
[02:44:40.159] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:40.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:18:0) after 1m0s
[02:45:40.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:18:0)
[02:45:40.489] Timer tick, asking Buildbucket for the build status
[02:45:40.580] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:40.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:19:0) after 1m0s
[02:46:40.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:19:0)
[02:46:40.794] Timer tick, asking Buildbucket for the build status
[02:46:40.894] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:40.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:20:0) after 1m0s
[02:47:41.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:20:0)
[02:47:41.106] Timer tick, asking Buildbucket for the build status
[02:47:41.223] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:41.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:21:0) after 1m0s
[02:48:41.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:21:0)
[02:48:41.480] Timer tick, asking Buildbucket for the build status
[02:48:41.577] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:41.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:22:0) after 1m0s
[02:49:41.701] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:22:0)
[02:49:41.701] Timer tick, asking Buildbucket for the build status
[02:49:41.839] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:41.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:23:0) after 1m0s
[02:50:42.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:23:0)
[02:50:42.071] Timer tick, asking Buildbucket for the build status
[02:50:42.161] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:42.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:24:0) after 1m0s
[02:51:42.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:24:0)
[02:51:42.231] Timer tick, asking Buildbucket for the build status
[02:51:42.330] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:42.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:25:0) after 1m0s
[02:52:42.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:25:0)
[02:52:42.470] Timer tick, asking Buildbucket for the build status
[02:52:42.651] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:42.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:26:0) after 1m0s
[02:53:42.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:26:0)
[02:53:42.713] Timer tick, asking Buildbucket for the build status
[02:53:42.796] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:42.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:27:0) after 1m0s
[02:54:42.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:27:0)
[02:54:42.861] Timer tick, asking Buildbucket for the build status
[02:54:42.940] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:42.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:28:0) after 1m0s
[02:55:43.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:28:0)
[02:55:43.039] Timer tick, asking Buildbucket for the build status
[02:55:43.120] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:43.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:29:0) after 1m0s
[02:56:43.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:29:0)
[02:56:43.234] Timer tick, asking Buildbucket for the build status
[02:56:43.318] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:43.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:30:0) after 1m0s
[02:57:43.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:30:0)
[02:57:43.312] Timer tick, asking Buildbucket for the build status
[02:57:43.383] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:43.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:31:0) after 1m0s
[02:58:43.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:31:0)
[02:58:43.549] Timer tick, asking Buildbucket for the build status
[02:58:43.728] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:43.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:32:0) after 1m0s
[02:59:43.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:32:0)
[02:59:43.771] Timer tick, asking Buildbucket for the build status
[02:59:43.859] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:43.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:33:0) after 1m0s
[03:00:43.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:33:0)
[03:00:43.975] Timer tick, asking Buildbucket for the build status
[03:00:44.172] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:44.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:34:0) after 1m0s
[03:01:44.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:34:0)
[03:01:44.219] Timer tick, asking Buildbucket for the build status
[03:01:44.421] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:44.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:35:0) after 1m0s
[03:02:44.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:35:0)
[03:02:44.477] Timer tick, asking Buildbucket for the build status
[03:02:44.545] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:44.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:36:0) after 1m0s
[03:03:44.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:36:0)
[03:03:44.546] Timer tick, asking Buildbucket for the build status
[03:03:44.667] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:37:0) after 1m0s
[03:04:44.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:37:0)
[03:04:44.699] Timer tick, asking Buildbucket for the build status
[03:04:44.806] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:44.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:38:0) after 1m0s
[03:05:44.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:38:0)
[03:05:44.875] Timer tick, asking Buildbucket for the build status
[03:05:44.947] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:44.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:39:0) after 1m0s
[03:06:45.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:39:0)
[03:06:45.094] Timer tick, asking Buildbucket for the build status
[03:06:45.531] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:45.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:40:0) after 1m0s
[03:07:45.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:40:0)
[03:07:45.596] Timer tick, asking Buildbucket for the build status
[03:07:45.661] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:45.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:41:0) after 1m0s
[03:08:45.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:41:0)
[03:08:45.808] Timer tick, asking Buildbucket for the build status
[03:08:45.879] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:45.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:42:0) after 1m0s
[03:09:45.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:42:0)
[03:09:45.860] Timer tick, asking Buildbucket for the build status
[03:09:46.048] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:46.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:43:0) after 1m0s
[03:10:46.070] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:43:0)
[03:10:46.070] Timer tick, asking Buildbucket for the build status
[03:10:46.143] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:46.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:44:0) after 1m0s
[03:11:46.214] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:44:0)
[03:11:46.214] Timer tick, asking Buildbucket for the build status
[03:11:46.302] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:46.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:45:0) after 1m0s
[03:12:46.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:45:0)
[03:12:46.338] Timer tick, asking Buildbucket for the build status
[03:12:46.415] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:46.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:46:0) after 1m0s
[03:13:46.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:46:0)
[03:13:46.442] Timer tick, asking Buildbucket for the build status
[03:13:46.553] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:46.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:47:0) after 1m0s
[03:14:46.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:47:0)
[03:14:46.614] Timer tick, asking Buildbucket for the build status
[03:14:46.705] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:46.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:48:0) after 1m0s
[03:15:46.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:48:0)
[03:15:46.821] Timer tick, asking Buildbucket for the build status
[03:15:46.892] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:46.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:49:0) after 1m0s
[03:16:46.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:49:0)
[03:16:46.976] Timer tick, asking Buildbucket for the build status
[03:16:47.041] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:47.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:50:0) after 1m0s
[03:17:47.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:50:0)
[03:17:47.120] Timer tick, asking Buildbucket for the build status
[03:17:47.305] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:47.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:51:0) after 1m0s
[03:18:47.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:51:0)
[03:18:47.399] Timer tick, asking Buildbucket for the build status
[03:18:47.637] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:47.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:52:0) after 1m0s
[03:19:47.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:52:0)
[03:19:47.733] Timer tick, asking Buildbucket for the build status
[03:19:47.853] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:47.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:53:0) after 1m0s
[03:20:47.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:53:0)
[03:20:47.958] Timer tick, asking Buildbucket for the build status
[03:20:48.035] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:48.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:54:0) after 1m0s
[03:21:48.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:54:0)
[03:21:48.060] Timer tick, asking Buildbucket for the build status
[03:21:48.174] Build 8853092823336156672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:48.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018522885280659360:55:0) after 1m0s
[03:22:43.608] Received PubSub notification, asking Buildbucket for the build status
[03:22:44.013] Build 8853092823336156672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:22:44.013] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615432962752285",
"created_by": "project:chromium",
"created_ts": "1615429775831401",
"id": "8853092823336156672",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22484832339af70186f4b4b277680a568dfe6dce\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"22484832339af70186f4b4b277680a568dfe6dce\", \"project\": \"chromium/src\"}], \"$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-qgyz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181287, \"got_angle_revision\": \"44b9579cf7b8d35cac13f9e2d70c57791ddfd0e2\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"22484832339af70186f4b4b277680a568dfe6dce\", \"got_revision_cp\": \"refs/heads/master@{#861810}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"380d3d23acddd8b6eb5521fbf5cf30b9ff8ac301\", \"got_v8_revision_cp\": \"refs/heads/9.1.95@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22484832339af70186f4b4b277680a568dfe6dce\", \"swarm_hashes_refs/heads/master(at){#861810}_without_patch\": {\"absl_hardening_tests\": \"50d15aadd34c35487cc25dcad65faca43ffe2d8d\", \"accessibility_unittests\": \"36333b855999569a549e3287519acfb691d88ad9\", \"angle_unittests\": \"a2d25f2721819e9f9104b5e2cc084a536d219a93\", \"app_shell_unittests\": \"5aa1439fb575135bc4f78a35a4f4eced91c77138\", \"aura_unittests\": \"2d85b1475b8782d08d81d5de99af7ceb98efd438\", \"base_unittests\": \"f389612a3e294b9288b70219dbfe8ee097bfa000\", \"base_util_unittests\": \"ab6585598d718d61144c999e66653053452c0554\", \"blink_common_unittests\": \"efea1a354bf269aba5ba303cedda20c7a3da5294\", \"blink_fuzzer_unittests\": \"92f2e9d29d38ac662f3fa19c406e384ab0c72672\", \"blink_heap_unittests\": \"cf25dd87b357dddf7dd16c3ad15257e93952dbe4\", \"blink_platform_unittests\": \"2c493a5401b003d8d1789aa16137074ada9fc6a6\", \"blink_python_tests\": \"ec4f5c0da03b26df947ccd62013c5fd0f640f5d5\", \"blink_unittests\": \"857b57fde2f1bed6a745b27c66ccfd3b481adfa6\", \"blink_web_tests\": \"90100e55984c00fd979b7fb2bbd0f2f0ad249826\", \"boringssl_crypto_tests\": \"7433f176159ad840de32cb1b33bba5deab931e4f\", \"boringssl_ssl_tests\": \"e64f88b38c1d9e6383001ac09b5f1c6347159803\", \"browser_tests\": \"2b52ff9d1809f61623084a0cf816934bd1a3892d\", \"capture_unittests\": \"5b76f81b53dec3c5cb4e4edf27fadd031912170e\", \"cast_unittests\": \"54b9d1c6f8d48abd677cb8518e274f0fe0a58428\", \"cc_unittests\": \"de6464d8cb08c071040f219e1e03506eae5ea1fb\", \"chrome_app_unittests\": \"00a4636bd2c2c6c1292d18812a3b60482701b97c\", \"chromedriver_unittests\": \"156670ac5e0a5a1f8df8c40021cdebbf5166d327\", \"color_unittests\": \"11f225960e71da3dddf1e7aa04c0b31d271535bb\", \"components_browsertests\": \"3b8541ef138133115ef599dd166977940c759288\", \"components_unittests\": \"994cdcdc4481882440fde539433f5a11c106caf4\", \"compositor_unittests\": \"aaa312666a43c29662362a27f1d848d52f6dd214\", \"content_browsertests\": \"ab107fb01cc0e44fa0efbc8dd6dd810c01bb2793\", \"content_shell_crash_test\": \"6bcd26421fa81275ff878eb753599a9cdbc40072\", \"content_unittests\": \"318b923669d8d7ee596f4a03e8d309f80389405c\", \"crashpad_tests\": \"1289fd478601b134c54cb14f3d46915f32a1c85e\", \"cronet_tests\": \"3682188476d2b97804a3dd5838a4838e78a223d2\", \"cronet_unittests\": \"42233ce1d36f2a3fb07d290ec041769c032aae36\", \"crypto_unittests\": \"45fa899725edd9291981fb6bfeb275c907e82eec\", \"dbus_unittests\": \"b5551720e0081c2ef750655af623650c33432a0c\", \"device_unittests\": \"2895140ea006ff70604ec525325a382f2360177d\", \"display_unittests\": \"4b5d13ee803c10c2719d6eb54e64de6deeab64c4\", \"events_unittests\": \"d96e627871d96ed2e8cda7689b2a1ece3e0e2e36\", \"extensions_browsertests\": \"09b800081649540a4defbe15185c7fca4e0a5e26\", \"extensions_unittests\": \"ce9866a230c23401150cbd6bf6a90f5bf5f17004\", \"filesystem_service_unittests\": \"3f1ccc4ebd89c331310370573f8b676c800fb277\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"2e591544aef6b5a7f85e5e1bb5571715d35cb0b3\", \"gfx_unittests\": \"4b821619a58b9ca85fc62baa372f9b6a274911a5\", \"gin_unittests\": \"8e699f67013e9e9b15d822e6df7b382607fac751\", \"google_apis_unittests\": \"df2836c68004109d6b3fc7be616fdf94dd9d7162\", \"gpu_unittests\": \"6089d48532509b19dd9fcfa91303e1278cae1554\", \"grit_python_unittests\": \"2629172029a5ce27ead3b3791972502f1e7f17c8\", \"gwp_asan_unittests\": \"dc3890f9de010ae330bfdae0afaf64b6f576dfda\", \"headless_browsertests\": \"781b0aa84f81e750382bb2ee356e72f56de0e3c1\", \"headless_unittests\": \"9f12e087b837d4afc7b5b2564e87b779222c0282\", \"interactive_ui_tests\": \"6b14411eb20d37e8f7d31a75d99de8a5f024bd76\", \"ipc_tests\": \"68e146113924ab8e9543faf0dc505c339b0c24a7\", \"jingle_unittests\": \"5bbe189ad1f333402474a662ddb08c90bbad4226\", \"latency_unittests\": \"86e3769e37e5adc3612c4691aec1e9b07c8dc12e\", \"libjingle_xmpp_unittests\": \"aae0633fd8873021b84fa7e49b3c38e922c4aa5f\", \"liburlpattern_unittests\": \"758bcd49f2e13f51201a184bc077e4fecbd9da8a\", \"media_blink_unittests\": \"113cd8f94a1dec604f510f0f16e7e253814aad47\", \"media_unittests\": \"829b8eb57b5985483a3e6c2b917992d3bce07d6b\", \"message_center_unittests\": \"105e5214eb2b426264d803a6fc28bf08a9394cd4\", \"metrics_python_tests\": \"f9ad1586f82f6ed6cb891778ea5f6d48ca421adb\", \"midi_unittests\": \"36881deeab5a4cb0574ced2f510becec103cbd2d\", \"mojo_core_unittests\": \"766f95783575c2c36f42ec0978f617c651ed6c67\", \"mojo_unittests\": \"937ddb29a5165f63fb5780b3a7cdf52bfc384314\", \"nacl_helper_nonsfi_unittests\": \"36bbb102015b9f2ec67ccb980e6a9afd3fd5f5ed\", \"nacl_loader_unittests\": \"003e95c41e476c7dd17f7cb4a4a4dcb684add937\", \"native_theme_unittests\": \"1e508eaa2064deebdf708266ed580570a0901808\", \"net_unittests\": \"c5f68769a40942a16e9cec760cb9a62b33977b9c\", \"openscreen_unittests\": \"eb39168b33fc764087c6b4d0e7c6fe7fdd0ac461\", \"pdf_unittests\": \"2600ec5db14988a3b879a59584c907a9d1352177\", \"perfetto_unittests\": \"6a95b761a31f5095a63aa85cd6f4c69e520d0d80\", \"ppapi_unittests\": \"9698cd254ec1f11336e74bf9b3b23b77b13829e3\", \"printing_unittests\": \"96294c680096b2131d92c54331776fe2a40951ba\", \"remoting_unittests\": \"7c5bfb1a3ba08c7c50cafb24d534105d587f3e38\", \"sandbox_linux_unittests\": \"39a86032747349350a012a8fa99a3055e5f3e29c\", \"service_manager_unittests\": \"a800561ea79780b1fcf389c501b91e08fbb7784b\", \"services_unittests\": \"a85ded5bc9c45698424009ba985a0640e0a71c42\", \"shell_dialogs_unittests\": \"95bd4b071ed96552316f2f6f49a458e1ccc9b369\", \"skia_unittests\": \"df2bca5ce23af570634da6b88533efed43b04c82\", \"snapshot_unittests\": \"43a5535c0a01c562dde10ff00d2fd84087e86045\", \"sql_unittests\": \"fec9ac3b4866585bb5228714944413d678426f61\", \"storage_unittests\": \"dd8fb6a5806e23ad0f37d172f9d92dd38c2d15e7\", \"sync_integration_tests\": \"ee3054f480c7183b80a15ff673e35ed764776760\", \"telemetry_gpu_unittests\": \"6ebabf449ac3c460fecfbe9b2dd756b85c0046cd\", \"telemetry_perf_unittests\": \"4406193ecd758eb028b53fdeb6b7767384fff704\", \"telemetry_unittests\": \"955e128221066c447dd6a033d4c98ff27e02ffab\", \"traffic_annotation_auditor_unittests\": \"f9523615293ae807a41bce40d1ea0641d6d4f4db\", \"ui_base_unittests\": \"1b050003f9568c9bed209657bd261f676d0a547b\", \"ui_touch_selection_unittests\": \"b02539c3d97d6e9e224535391b230ff8745ced03\", \"unit_tests\": \"8b36b8bf4bbf1bfb39a2cb85c2b7c2d920da4abb\", \"url_unittests\": \"6e550978376453c94c5e7d6aea551343f50f9909\", \"views_perftests\": \"63e3f96f41520997da55af4e290ab202f8b73295\", \"views_unittests\": \"e34a697f4b157215ad15344a5d138991bd20b32d\", \"viz_unittests\": \"7f348eed4c2f1dfd884c45823a87b58049bdc49e\", \"vr_common_unittests\": \"7bfb915f53d36e4585ffaabb6666245416ee9da6\", \"vr_pixeltests\": \"084d165268cbaf8eb3a2fe72afd84958daf47168\", \"webdriver_wpt_tests\": \"0451d85169df1b6e4aad4b72e08df79951449ef9\", \"weblayer_browsertests\": \"21c1e40322444024e09dfcf29e386bae4a16a044\", \"weblayer_unittests\": \"f2d70005ed6b482da49785923a3c57e3920034bd\", \"wm_unittests\": \"a890756577fe11a536b2a487700f27553b9a2847\", \"wtf_unittests\": \"494613c31dbba6ba987b32ae964e5e2ab579a46e\", \"x11_unittests\": \"956baba67123c401d50399615405aa9a341d8926\", \"xr_browser_tests\": \"b34bddde42a0a0c1eb83c0628d97437dc5c88b7f\", \"zlib_unittests\": \"138b342eec3ac6f6a976214a1771b8dddbf8278d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_13c9e4757ca6a1772742c665222564667630a6453df92e57dfb1ace791cbcc32_v2\", \"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-120-qgyz\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615429784506867",
"status": "COMPLETED",
"status_changed_ts": "1615432963158371",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181287",
"builder:Linux Builder (dbg)",
"buildset:commit/git/22484832339af70186f4b4b277680a568dfe6dce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22484832339af70186f4b4b277680a568dfe6dce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018522885280659360",
"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/8853092823336156672/+/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:5237efc3b4fc9b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615432963163005",
"url": "https://ci.chromium.org/b/8853092823336156672",
"utcnow_ts": "1615432963996518"
}
}
[03:22:44.013] Invocation finished in 53m9.419931497s with status SUCCEEDED