[09:34:28.100] New invocation is queued and will start shortly
[09:34:29.257] Starting the invocation (attempt 1)
[09:34:29.324] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:34:29.324] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:34:29.324] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060442548871074880",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"40f9fb67990cd6e8806a9a7a072453a2ad85f397\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060442548871074880",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/40f9fb67990cd6e8806a9a7a072453a2ad85f397",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40f9fb67990cd6e8806a9a7a072453a2ad85f397",
"gitiles_ref:refs/heads/master"
]
}
[09:34:30.096] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575452069510189",
"id": "8895012486720134400",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40f9fb67990cd6e8806a9a7a072453a2ad85f397\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575452069931040",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165637",
"builder:Linux Builder (dbg)",
"buildset:commit/git/40f9fb67990cd6e8806a9a7a072453a2ad85f397",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40f9fb67990cd6e8806a9a7a072453a2ad85f397",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060442548871074880",
"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/8895012486720134400/+/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": "1575452069931865",
"url": "https://ci.chromium.org/b/8895012486720134400",
"utcnow_ts": "1575452070083131"
}
}
[09:34:30.096] Task URL: https://ci.chromium.org/b/8895012486720134400
[09:34:30.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:2:0) after 1m0s
[09:35:30.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:2:0)
[09:35:30.166] Timer tick, asking Buildbucket for the build status
[09:35:30.440] Build 8895012486720134400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:30.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:3:0) after 1m0s
[09:36:30.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:3:0)
[09:36:30.493] Timer tick, asking Buildbucket for the build status
[09:36:30.994] Build 8895012486720134400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:30.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:4:0) after 1m0s
[09:37:31.120] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:4:0)
[09:37:31.120] Timer tick, asking Buildbucket for the build status
[09:37:32.022] Build 8895012486720134400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:32.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:5:0) after 1m0s
[09:38:32.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:5:0)
[09:38:32.145] Timer tick, asking Buildbucket for the build status
[09:38:32.455] Build 8895012486720134400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:32.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:6:0) after 1m0s
[09:39:03.150] Received PubSub notification, asking Buildbucket for the build status
[09:39:03.336] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:32.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:6:0)
[09:39:32.473] Timer tick, asking Buildbucket for the build status
[09:39:32.691] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:32.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:8:0) after 1m0s
[09:40:32.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:8:0)
[09:40:32.765] Timer tick, asking Buildbucket for the build status
[09:40:33.012] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:33.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:9:0) after 1m0s
[09:41:33.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:9:0)
[09:41:33.194] Timer tick, asking Buildbucket for the build status
[09:41:33.645] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:33.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:10:0) after 1m0s
[09:42:33.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:10:0)
[09:42:33.721] Timer tick, asking Buildbucket for the build status
[09:42:34.450] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:34.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:11:0) after 1m0s
[09:43:34.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:11:0)
[09:43:34.550] Timer tick, asking Buildbucket for the build status
[09:43:36.061] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:36.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:12:0) after 1m0s
[09:44:36.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:12:0)
[09:44:36.128] Timer tick, asking Buildbucket for the build status
[09:44:36.775] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:36.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:13:0) after 1m0s
[09:45:36.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:13:0)
[09:45:36.836] Timer tick, asking Buildbucket for the build status
[09:45:37.428] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:14:0) after 1m0s
[09:46:37.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:14:0)
[09:46:37.428] Timer tick, asking Buildbucket for the build status
[09:46:37.602] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:37.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:15:0) after 1m0s
[09:47:37.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:15:0)
[09:47:37.755] Timer tick, asking Buildbucket for the build status
[09:47:38.128] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:38.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:16:0) after 1m0s
[09:48:38.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:16:0)
[09:48:38.260] Timer tick, asking Buildbucket for the build status
[09:48:39.647] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:39.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:17:0) after 1m0s
[09:49:39.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:17:0)
[09:49:39.750] Timer tick, asking Buildbucket for the build status
[09:49:39.967] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:39.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:18:0) after 1m0s
[09:50:39.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:18:0)
[09:50:39.997] Timer tick, asking Buildbucket for the build status
[09:50:40.434] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:40.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:19:0) after 1m0s
[09:51:40.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:19:0)
[09:51:40.458] Timer tick, asking Buildbucket for the build status
[09:51:41.003] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:41.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:20:0) after 1m0s
[09:52:41.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:20:0)
[09:52:41.074] Timer tick, asking Buildbucket for the build status
[09:52:41.448] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:41.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:21:0) after 1m0s
[09:53:41.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:21:0)
[09:53:41.539] Timer tick, asking Buildbucket for the build status
[09:53:41.753] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:41.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:22:0) after 1m0s
[09:54:41.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:22:0)
[09:54:41.808] Timer tick, asking Buildbucket for the build status
[09:54:41.948] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:41.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:23:0) after 1m0s
[09:55:42.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:23:0)
[09:55:42.035] Timer tick, asking Buildbucket for the build status
[09:55:42.756] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:42.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:24:0) after 1m0s
[09:56:42.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:24:0)
[09:56:42.979] Timer tick, asking Buildbucket for the build status
[09:56:43.474] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:43.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:25:0) after 1m0s
[09:57:43.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:25:0)
[09:57:43.592] Timer tick, asking Buildbucket for the build status
[09:57:43.776] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:43.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:26:0) after 1m0s
[09:58:43.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:26:0)
[09:58:43.791] Timer tick, asking Buildbucket for the build status
[09:58:45.329] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:45.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:27:0) after 1m0s
[09:59:45.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:27:0)
[09:59:45.478] Timer tick, asking Buildbucket for the build status
[09:59:46.005] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:46.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:28:0) after 1m0s
[10:00:46.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:28:0)
[10:00:46.137] Timer tick, asking Buildbucket for the build status
[10:00:46.759] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:46.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:29:0) after 1m0s
[10:01:46.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:29:0)
[10:01:46.860] Timer tick, asking Buildbucket for the build status
[10:01:47.207] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:47.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:30:0) after 1m0s
[10:02:47.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:30:0)
[10:02:47.238] Timer tick, asking Buildbucket for the build status
[10:02:47.431] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:47.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:31:0) after 1m0s
[10:03:47.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:31:0)
[10:03:47.535] Timer tick, asking Buildbucket for the build status
[10:03:48.149] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:48.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:32:0) after 1m0s
[10:04:48.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:32:0)
[10:04:48.183] Timer tick, asking Buildbucket for the build status
[10:04:48.912] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:48.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:33:0) after 1m0s
[10:05:48.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:33:0)
[10:05:48.918] Timer tick, asking Buildbucket for the build status
[10:05:49.180] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:49.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:34:0) after 1m0s
[10:06:49.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:34:0)
[10:06:49.255] Timer tick, asking Buildbucket for the build status
[10:06:49.665] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:49.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:35:0) after 1m0s
[10:07:49.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:35:0)
[10:07:49.766] Timer tick, asking Buildbucket for the build status
[10:07:50.059] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:50.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:36:0) after 1m0s
[10:08:50.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:36:0)
[10:08:50.157] Timer tick, asking Buildbucket for the build status
[10:08:50.815] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:50.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:37:0) after 1m0s
[10:09:50.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:37:0)
[10:09:50.859] Timer tick, asking Buildbucket for the build status
[10:09:51.187] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:51.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:38:0) after 1m0s
[10:10:51.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:38:0)
[10:10:51.353] Timer tick, asking Buildbucket for the build status
[10:10:51.497] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:51.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:39:0) after 1m0s
[10:11:51.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:39:0)
[10:11:51.659] Timer tick, asking Buildbucket for the build status
[10:11:51.858] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:51.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:40:0) after 1m0s
[10:12:51.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:40:0)
[10:12:51.909] Timer tick, asking Buildbucket for the build status
[10:12:52.122] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:52.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:41:0) after 1m0s
[10:13:52.191] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:41:0)
[10:13:52.191] Timer tick, asking Buildbucket for the build status
[10:13:54.232] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:54.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:42:0) after 1m0s
[10:14:54.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:42:0)
[10:14:54.267] Timer tick, asking Buildbucket for the build status
[10:14:55.394] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:55.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:43:0) after 1m0s
[10:15:55.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:43:0)
[10:15:55.489] Timer tick, asking Buildbucket for the build status
[10:15:55.745] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:55.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:44:0) after 1m0s
[10:16:55.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:44:0)
[10:16:55.784] Timer tick, asking Buildbucket for the build status
[10:16:56.087] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:56.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:45:0) after 1m0s
[10:17:56.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:45:0)
[10:17:56.178] Timer tick, asking Buildbucket for the build status
[10:17:57.220] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:57.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:46:0) after 1m0s
[10:18:57.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:46:0)
[10:18:57.291] Timer tick, asking Buildbucket for the build status
[10:18:58.004] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:58.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:47:0) after 1m0s
[10:19:58.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:47:0)
[10:19:58.115] Timer tick, asking Buildbucket for the build status
[10:19:58.363] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:58.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:48:0) after 1m0s
[10:20:58.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:48:0)
[10:20:58.450] Timer tick, asking Buildbucket for the build status
[10:20:58.632] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:58.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:49:0) after 1m0s
[10:21:58.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:49:0)
[10:21:58.751] Timer tick, asking Buildbucket for the build status
[10:21:58.990] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:58.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:50:0) after 1m0s
[10:22:59.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:50:0)
[10:22:59.102] Timer tick, asking Buildbucket for the build status
[10:22:59.491] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:59.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:51:0) after 1m0s
[10:23:59.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:51:0)
[10:23:59.490] Timer tick, asking Buildbucket for the build status
[10:24:01.960] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:01.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:52:0) after 1m0s
[10:25:02.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:52:0)
[10:25:02.021] Timer tick, asking Buildbucket for the build status
[10:25:02.295] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:02.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:53:0) after 1m0s
[10:26:02.320] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:53:0)
[10:26:02.320] Timer tick, asking Buildbucket for the build status
[10:26:02.662] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:02.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:54:0) after 1m0s
[10:27:02.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:54:0)
[10:27:02.684] Timer tick, asking Buildbucket for the build status
[10:27:02.998] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:02.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:55:0) after 1m0s
[10:28:03.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:55:0)
[10:28:03.056] Timer tick, asking Buildbucket for the build status
[10:28:03.288] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:03.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:56:0) after 1m0s
[10:29:03.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:56:0)
[10:29:03.311] Timer tick, asking Buildbucket for the build status
[10:29:04.094] Build 8895012486720134400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:04.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060442548871074880:57:0) after 1m0s
[10:29:04.610] Received PubSub notification, asking Buildbucket for the build status
[10:29:04.876] Build 8895012486720134400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:29:04.876] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575455343791785",
"created_by": "project:chromium",
"created_ts": "1575452069510189",
"id": "8895012486720134400",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40f9fb67990cd6e8806a9a7a072453a2ad85f397\"}}",
"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-46-zpq8\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165637, \"got_angle_revision\": \"249cb200173f3fcbd5055399fee0a3e5b8721c86\", \"got_dawn_revision\": \"53782d60dc73f309726e1e858ae4b42127c3cbad\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"40f9fb67990cd6e8806a9a7a072453a2ad85f397\", \"got_revision_cp\": \"refs/heads/master@{#721405}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"bbd0694f9ab2fbcebba7f674d832dcca9a898a59\", \"got_v8_revision\": \"adfb6ba32d881a5bba73f9c7121ca9f8dba881b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.418@{#1}\", \"got_webrtc_revision\": \"89313451d8e2338845716b0ab8760ed0552580f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29962}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40f9fb67990cd6e8806a9a7a072453a2ad85f397\", \"swarm_hashes_refs/heads/master(at){#721405}_without_patch\": {\"accessibility_unittests\": \"d987a7f80e15871f04280e04f321eb341e37e8c6\", \"angle_unittests\": \"84fd2212c50ac784b6566cd9427aefc3a605053b\", \"app_shell_unittests\": \"4246fcd5bff6ab908d50f8660c7fd71e07a7c4e3\", \"aura_unittests\": \"c6d63e0c006910adfcd5bef47b7bbe608b15aef9\", \"base_unittests\": \"13bd4cc03585df1c8a0db813647f7e48dbb2def0\", \"base_util_unittests\": \"3ad5b9b7a1528e9cf4b13dace2108495617a70ca\", \"blink_common_unittests\": \"e74d56f14ec4b595327ec88596b5100131ec824c\", \"blink_fuzzer_unittests\": \"79c0e5f33689f27d975a121bb66abd343972868c\", \"blink_heap_unittests\": \"2379f48f5f235649794e7902f9d77e44b8ab8d4c\", \"blink_platform_unittests\": \"b1f19e5dad42770065b2cc403a19e4f88f98e903\", \"blink_python_tests\": \"be623715b95feee8b69662130951f2b1d7ec0ba1\", \"blink_unittests\": \"8133dba552103c744f2aac7a9d4d08b33ad516c0\", \"blink_web_tests_exparchive\": \"ba56883d05394d63cbb77d51b32fcad8969ef2af\", \"boringssl_crypto_tests\": \"092bd7a5556f4634bd146ef9aae8f47197cf1aeb\", \"boringssl_ssl_tests\": \"5de48179a5047cca5b38e48e899b94fdf11ac7c4\", \"browser_tests\": \"54a4bd22b2ee960c7f86dea1d4d825871181d521\", \"cacheinvalidation_unittests\": \"4d247214e14c11a85e98ef55e2ae2964634046b6\", \"capture_unittests\": \"d0e9180e27e16b6cef72395e8bc3fad5c5ac9805\", \"cast_unittests\": \"3f5e7e670cd6c52680051c8edb9798e505712862\", \"cc_unittests\": \"649601e0f5a4da6bffbd208d0f828989bbf15cb0\", \"chrome_app_unittests\": \"665047b9db43e58a1e66d314ab1df58d7a3dc8ea\", \"chromedriver_unittests\": \"7ec21fd4352bf1cb0a44a1a7571d5573747d1493\", \"components_browsertests\": \"2a18b6eba5f1af753a9a4dca83db9e8e4895edd1\", \"components_unittests\": \"baa7314fed8565e8f82db1184756ab12a9a3d269\", \"compositor_unittests\": \"c3f8d5ae677b64008ac88d7f0c5540d3a63ae692\", \"content_browsertests\": \"299a5fc5b65c23a13076888e00d495d7a51d5e15\", \"content_shell_crash_test\": \"21f87b81c854d681f82831c50c7adcbe9353952f\", \"content_unittests\": \"b059c60ecf134a969121b94b59316e8deef02472\", \"crashpad_tests\": \"494c053ff553463e6fc40551776e83b8fafdcb1b\", \"cronet_tests\": \"405fac3ab362b5a578a10bab9ff8a92b395e1329\", \"cronet_unittests\": \"d2bae55a2bfbc0ae4d3af9a85819fa5eebc413e6\", \"crypto_unittests\": \"83cbf97c72e5f31a78c2fe0a2418cd788c918649\", \"dbus_unittests\": \"8009735c9d3651e793e3ee16661ac4cda6cf21c6\", \"device_unittests\": \"adad157d725e697909da804150abe67547e6fea0\", \"devtools_lint_check\": \"d4569f729ec7dfedf9471bd7141505803d6edd32\", \"devtools_type_check\": \"07c847e65cec8599681255547909941a257a17f7\", \"display_unittests\": \"84e4c61ccdf92613fb4310ce338d2c1aa9c9d653\", \"events_unittests\": \"9bb78ec1ada4f955f561259cba2992b847d066e4\", \"extensions_browsertests\": \"ba17e8127436191d16f3a1924900a345e71475db\", \"extensions_unittests\": \"23a896b61e12ecbd1537acd622802ddd847bd74f\", \"filesystem_service_unittests\": \"510ab8f9f7c79f6232b374edf39ef8bd05c616d9\", \"flatbuffers_unittests\": \"87cf3d4f1486d42f8595ee02362ad0fa22286571\", \"gcm_unit_tests\": \"a008978608d3774da0da1e4bd70bb7a934e790bc\", \"gfx_unittests\": \"65ed1f5c85d8fb7722b9581decbe90287c906a71\", \"gin_unittests\": \"d179283fd894467173656e9b49f0cc6086d669f3\", \"google_apis_unittests\": \"02cecfd73f4801d585cb540e8ef951923ea15309\", \"gpu_unittests\": \"880157f1b3b75532b91e08aa6b1380508cdb8b05\", \"grit_python_unittests\": \"e63c825e2bc8b1d341a853f965d6a4f9c0d6c54f\", \"gwp_asan_unittests\": \"45db51d13f6fbbf0b4e643bc14c57bee0b13410a\", \"headless_browsertests\": \"9251fc61aa40de0f3610276ee48c65b77c2e6b43\", \"headless_unittests\": \"6b6061a043e1f66fc7aa4561ef5c809f1517a637\", \"interactive_ui_tests\": \"e8dfd643f39a5075355572a88817a7ee6cec69e4\", \"ipc_tests\": \"2db134c919f91798a78bd629b7e32e13137039bd\", \"jingle_unittests\": \"597d82b3e795a6696c4a66aaa95f3334f66511bb\", \"latency_unittests\": \"9e9e291c45cfcd7a4d3d6989765eac0138327254\", \"libjingle_xmpp_unittests\": \"aa15c1f994c1398122dd691500ed40a1b6b18851\", \"media_blink_unittests\": \"6da99dd5943ed82ff23ccb546a92656ff0cfcbdb\", \"media_service_unittests\": \"343e5b6c1881491113df0927248f11ecabc641de\", \"media_unittests\": \"43543d90f41d641bc65d65e9e1c48bccfbc87e17\", \"message_center_unittests\": \"04b494a0dcb06b3cae95fc8e7b10c1132cc552c7\", \"metrics_python_tests\": \"f68e17ed127352cc9864aa296f4f0cad8e362866\", \"midi_unittests\": \"d2e0d98cffceea23cb7631704075765cbdd1314b\", \"mojo_core_unittests\": \"3c4e77d5fc8ea8be45c1e236a3d1dc97b889da0c\", \"mojo_unittests\": \"ea2ec85017c8698a652e777ce21e49650bc9e5a5\", \"nacl_helper_nonsfi_unittests\": \"8497a31a9503b126476da231cce1c78bd1047041\", \"nacl_loader_unittests\": \"4c8178dad19484206d22a60937482c4b7f6b0400\", \"native_theme_unittests\": \"1097ed57358f4a6a01a06ea607b39af2749befcf\", \"net_unittests\": \"64e67a1eb1fbcc4744ad60a7eec24989642e7fda\", \"pdf_unittests\": \"8ad5bde05c1c0d7a8afcf3850b096088b94fa7e1\", \"perfetto_unittests\": \"037fc9d3deb6c853c532909504cc55c399833dc5\", \"ppapi_unittests\": \"eb00d2961ffd6798696281992d0680647ffe26df\", \"printing_unittests\": \"248f1379306b70b4b03c5de4f026b556bffcd4fb\", \"remoting_unittests\": \"6a329d976bd8f33b1bf26f26b193b9f623dd5439\", \"sandbox_linux_unittests\": \"e6ae271ee9224777c6edf9ab07dcfcf0154370be\", \"service_manager_unittests\": \"b21ea62fea14c6c2330b3640ba20fce15aca1688\", \"services_unittests\": \"1bfa9634e63baea5c5bbdae1722eca618865efcf\", \"shell_dialogs_unittests\": \"b2cd57a80e6d1c98c96f2fe798df050dd38e8488\", \"skia_unittests\": \"162646205c90ea524038c46d9593ed306c8692d4\", \"snapshot_unittests\": \"48576d22680d160033a85c386c103d82405ba8af\", \"sql_unittests\": \"1c76b7d8b0781205a8603cd5dcc968c9dd9502d4\", \"storage_unittests\": \"4112833b40de4161a3238ef40090138297dff92b\", \"sync_integration_tests\": \"050976c6aba437245d6f063d73b55893f4dcbe4a\", \"telemetry_gpu_unittests\": \"fc38c1afa76c58c1524bf55163e66d7d5f3275ef\", \"telemetry_perf_unittests\": \"f0e795e61e183e8f8b14c85d411d9879bdb59acd\", \"telemetry_unittests\": \"74cbf0c7c5f6323babe377cf5f6288e950c33855\", \"traffic_annotation_auditor_unittests\": \"3b59a6578379bc7a35b98c6ff1ea32e8db0014e1\", \"ui_base_unittests\": \"98e0e34e7094a1195bc3c6416114a389e5f44867\", \"ui_touch_selection_unittests\": \"24ea12eb93114e91c54870dabd86ca1d629565b7\", \"unit_tests\": \"34d0738ab64c92855cd81d680dcf7e368a4f31e9\", \"url_unittests\": \"01ed1aa0d7303ef4e719a870c47854ebaf88a851\", \"views_perftests\": \"7c05d3fd638831f9a00fc5cd81794f91fd9098be\", \"views_unittests\": \"15906d96a3648e33625179c9f7c5c61472c15fb9\", \"viz_unittests\": \"e0f366b5f80d8775d0ddb449f987275cbc2bdb2c\", \"vr_common_unittests\": \"42f3f4ec8017708fa492c73392802b658d571c4f\", \"vr_pixeltests\": \"edac31d0753d7985d590a5d1f45e05c2f47e83c2\", \"webdriver_wpt_tests\": \"616474be1f1787d51e48b11bf8192d7a7180de49\", \"weblayer_browsertests\": \"daea04b1fa1d1b23ee2d9608b318231ca1fac60b\", \"wm_unittests\": \"6037cc75a20aa6e563f2a800c676361ce491b241\", \"wtf_unittests\": \"ce53f8a485ca64b251594e859217bfeb35dc918b\", \"xr_browser_tests\": \"624460bf28c0b040f7a18ddeec44710a30c83239\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-46-zpq8\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4693-40b2cd3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575452342368250",
"status": "COMPLETED",
"status_changed_ts": "1575455344177313",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165637",
"builder:Linux Builder (dbg)",
"buildset:commit/git/40f9fb67990cd6e8806a9a7a072453a2ad85f397",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40f9fb67990cd6e8806a9a7a072453a2ad85f397",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060442548871074880",
"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/8895012486720134400/+/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:48e9145b26233510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575455344182821",
"url": "https://ci.chromium.org/b/8895012486720134400",
"utcnow_ts": "1575455344862199"
}
}
[10:29:04.876] Invocation finished in 54m36.801619201s with status SUCCEEDED