[04:00:28.372] New invocation is queued and will start shortly
[04:00:28.372] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[04:00:29.582] Starting the invocation (attempt 1)
[04:00:29.619] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:29.619] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:29.619] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9086193100499421824",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-android\",\"properties\":{\"root_solution_revision\":\"883bce6f15273bc4adadb62393b115a5aaed2564\",\"root_solution_revision_timestamp\":1550894234}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-android",
"scheduler_invocation_id:9086193100499421824",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:7631",
"user_agent:recipe"
]
}
[04:00:30.682] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550894429695356",
"id": "8920763038446547728",
"lease_expiration_ts": "1551016830355187",
"lease_key": "501203973",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-android\", \"properties\": {\"root_solution_revision\": \"883bce6f15273bc4adadb62393b115a5aaed2564\", \"root_solution_revision_timestamp\": 1550894234}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550894430486832",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/4382",
"builder:codesearch-gen-chromium-android",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:7631",
"scheduler_invocation_id:9086193100499421824",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8920763038446547728/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4331547f83387210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1550894430486950",
"url": "https://ci.chromium.org/b/8920763038446547728",
"utcnow_ts": "1550894430671425"
}
}
[04:00:30.682] Task URL: https://ci.chromium.org/b/8920763038446547728
[04:00:30.682] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:2:0) after 1m0s
[04:00:45.439] Received PubSub notification, asking Buildbucket for the build status
[04:00:45.578] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:30.722] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:2:0)
[04:01:30.722] Timer tick, asking Buildbucket for the build status
[04:01:31.000] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:31.000] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:4:0) after 1m0s
[04:02:31.019] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:4:0)
[04:02:31.019] Timer tick, asking Buildbucket for the build status
[04:02:31.123] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:31.123] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:5:0) after 1m0s
[04:03:31.152] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:5:0)
[04:03:31.152] Timer tick, asking Buildbucket for the build status
[04:03:31.279] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:31.279] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:6:0) after 1m0s
[04:04:31.297] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:6:0)
[04:04:31.297] Timer tick, asking Buildbucket for the build status
[04:04:31.411] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:31.411] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:7:0) after 1m0s
[04:05:31.429] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:7:0)
[04:05:31.429] Timer tick, asking Buildbucket for the build status
[04:05:31.528] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:31.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:8:0) after 1m0s
[04:06:31.545] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:8:0)
[04:06:31.545] Timer tick, asking Buildbucket for the build status
[04:06:31.716] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:31.716] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:9:0) after 1m0s
[04:07:31.734] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:9:0)
[04:07:31.734] Timer tick, asking Buildbucket for the build status
[04:07:31.820] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:31.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:10:0) after 1m0s
[04:08:31.835] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:10:0)
[04:08:31.835] Timer tick, asking Buildbucket for the build status
[04:08:31.949] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:31.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:11:0) after 1m0s
[04:09:31.981] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:11:0)
[04:09:31.981] Timer tick, asking Buildbucket for the build status
[04:09:32.051] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:32.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:12:0) after 1m0s
[04:10:32.064] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:12:0)
[04:10:32.064] Timer tick, asking Buildbucket for the build status
[04:10:32.202] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:32.202] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:13:0) after 1m0s
[04:11:32.221] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:13:0)
[04:11:32.221] Timer tick, asking Buildbucket for the build status
[04:11:32.297] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:32.297] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:14:0) after 1m0s
[04:12:32.336] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:14:0)
[04:12:32.336] Timer tick, asking Buildbucket for the build status
[04:12:32.388] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:32.388] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:15:0) after 1m0s
[04:13:32.408] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:15:0)
[04:13:32.408] Timer tick, asking Buildbucket for the build status
[04:13:32.634] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:32.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:16:0) after 1m0s
[04:14:32.651] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:16:0)
[04:14:32.651] Timer tick, asking Buildbucket for the build status
[04:14:32.704] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:32.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:17:0) after 1m0s
[04:15:32.723] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:17:0)
[04:15:32.723] Timer tick, asking Buildbucket for the build status
[04:15:32.785] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:32.785] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:18:0) after 1m0s
[04:16:32.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:18:0)
[04:16:32.802] Timer tick, asking Buildbucket for the build status
[04:16:32.864] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:32.864] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:19:0) after 1m0s
[04:17:32.884] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:19:0)
[04:17:32.884] Timer tick, asking Buildbucket for the build status
[04:17:32.947] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:32.947] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:20:0) after 1m0s
[04:18:32.972] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:20:0)
[04:18:32.972] Timer tick, asking Buildbucket for the build status
[04:18:33.134] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:33.134] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:21:0) after 1m0s
[04:19:33.229] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:21:0)
[04:19:33.229] Timer tick, asking Buildbucket for the build status
[04:19:33.417] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:33.417] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:22:0) after 1m0s
[04:20:33.511] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:22:0)
[04:20:33.511] Timer tick, asking Buildbucket for the build status
[04:20:33.809] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:33.809] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:23:0) after 1m0s
[04:21:33.830] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:23:0)
[04:21:33.830] Timer tick, asking Buildbucket for the build status
[04:21:33.893] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:33.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:24:0) after 1m0s
[04:22:33.911] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:24:0)
[04:22:33.911] Timer tick, asking Buildbucket for the build status
[04:22:34.114] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:34.114] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:25:0) after 1m0s
[04:23:34.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:25:0)
[04:23:34.165] Timer tick, asking Buildbucket for the build status
[04:23:34.223] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:34.223] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:26:0) after 1m0s
[04:24:34.248] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:26:0)
[04:24:34.248] Timer tick, asking Buildbucket for the build status
[04:24:34.292] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:34.292] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:27:0) after 1m0s
[04:25:34.353] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:27:0)
[04:25:34.353] Timer tick, asking Buildbucket for the build status
[04:25:34.613] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:34.613] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:28:0) after 1m0s
[04:26:34.637] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:28:0)
[04:26:34.637] Timer tick, asking Buildbucket for the build status
[04:26:34.735] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:34.735] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:29:0) after 1m0s
[04:27:34.751] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:29:0)
[04:27:34.751] Timer tick, asking Buildbucket for the build status
[04:27:34.860] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:34.860] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:30:0) after 1m0s
[04:28:34.881] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:30:0)
[04:28:34.881] Timer tick, asking Buildbucket for the build status
[04:28:35.089] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:35.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:31:0) after 1m0s
[04:29:35.108] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:31:0)
[04:29:35.108] Timer tick, asking Buildbucket for the build status
[04:29:35.186] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:35.186] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:32:0) after 1m0s
[04:30:35.205] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:32:0)
[04:30:35.205] Timer tick, asking Buildbucket for the build status
[04:30:35.309] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:35.309] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:33:0) after 1m0s
[04:31:35.326] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:33:0)
[04:31:35.326] Timer tick, asking Buildbucket for the build status
[04:31:35.634] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:35.635] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:34:0) after 1m0s
[04:32:35.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:34:0)
[04:32:35.653] Timer tick, asking Buildbucket for the build status
[04:32:35.730] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:35.730] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:35:0) after 1m0s
[04:33:35.750] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:35:0)
[04:33:35.750] Timer tick, asking Buildbucket for the build status
[04:33:35.824] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:35.824] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:36:0) after 1m0s
[04:34:35.841] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:36:0)
[04:34:35.841] Timer tick, asking Buildbucket for the build status
[04:34:35.992] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:35.992] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:37:0) after 1m0s
[04:35:36.011] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:37:0)
[04:35:36.011] Timer tick, asking Buildbucket for the build status
[04:35:36.174] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:36.174] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:38:0) after 1m0s
[04:36:36.192] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:38:0)
[04:36:36.192] Timer tick, asking Buildbucket for the build status
[04:36:36.258] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:36.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:39:0) after 1m0s
[04:37:36.281] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:39:0)
[04:37:36.281] Timer tick, asking Buildbucket for the build status
[04:37:36.322] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:36.322] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:40:0) after 1m0s
[04:38:36.340] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:40:0)
[04:38:36.340] Timer tick, asking Buildbucket for the build status
[04:38:36.473] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:36.473] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:41:0) after 1m0s
[04:39:36.492] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:41:0)
[04:39:36.492] Timer tick, asking Buildbucket for the build status
[04:39:36.532] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:36.532] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:42:0) after 1m0s
[04:40:36.548] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:42:0)
[04:40:36.548] Timer tick, asking Buildbucket for the build status
[04:40:36.633] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:36.633] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:43:0) after 1m0s
[04:41:36.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:43:0)
[04:41:36.653] Timer tick, asking Buildbucket for the build status
[04:41:36.721] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:36.721] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:44:0) after 1m0s
[04:42:36.753] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:44:0)
[04:42:36.753] Timer tick, asking Buildbucket for the build status
[04:42:36.991] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:36.991] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:45:0) after 1m0s
[04:43:37.017] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:45:0)
[04:43:37.017] Timer tick, asking Buildbucket for the build status
[04:43:37.103] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:37.103] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:46:0) after 1m0s
[04:44:37.126] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:46:0)
[04:44:37.126] Timer tick, asking Buildbucket for the build status
[04:44:37.175] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:37.175] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:47:0) after 1m0s
[04:45:37.197] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:47:0)
[04:45:37.197] Timer tick, asking Buildbucket for the build status
[04:45:37.255] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:37.255] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:48:0) after 1m0s
[04:46:37.271] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:48:0)
[04:46:37.272] Timer tick, asking Buildbucket for the build status
[04:46:37.329] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.329] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:49:0) after 1m0s
[04:47:37.400] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:49:0)
[04:47:37.400] Timer tick, asking Buildbucket for the build status
[04:47:37.450] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:37.450] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:50:0) after 1m0s
[04:48:37.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:50:0)
[04:48:37.487] Timer tick, asking Buildbucket for the build status
[04:48:37.554] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:37.554] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:51:0) after 1m0s
[04:49:37.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:51:0)
[04:49:37.573] Timer tick, asking Buildbucket for the build status
[04:49:37.764] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:37.764] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:52:0) after 1m0s
[04:50:37.781] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:52:0)
[04:50:37.781] Timer tick, asking Buildbucket for the build status
[04:50:37.922] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:37.922] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:53:0) after 1m0s
[04:51:37.943] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:53:0)
[04:51:37.943] Timer tick, asking Buildbucket for the build status
[04:51:38.015] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:38.015] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:54:0) after 1m0s
[04:52:38.032] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:54:0)
[04:52:38.032] Timer tick, asking Buildbucket for the build status
[04:52:38.116] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:38.116] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:55:0) after 1m0s
[04:53:38.142] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:55:0)
[04:53:38.142] Timer tick, asking Buildbucket for the build status
[04:53:38.195] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:38.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:56:0) after 1m0s
[04:54:38.216] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:56:0)
[04:54:38.216] Timer tick, asking Buildbucket for the build status
[04:54:38.254] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.254] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:57:0) after 1m0s
[04:55:38.273] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:57:0)
[04:55:38.273] Timer tick, asking Buildbucket for the build status
[04:55:38.331] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:38.331] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:58:0) after 1m0s
[04:56:38.354] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:58:0)
[04:56:38.354] Timer tick, asking Buildbucket for the build status
[04:56:38.539] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:38.539] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:59:0) after 1m0s
[04:57:38.557] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:59:0)
[04:57:38.557] Timer tick, asking Buildbucket for the build status
[04:57:38.619] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:38.619] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:60:0) after 1m0s
[04:58:38.636] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:60:0)
[04:58:38.636] Timer tick, asking Buildbucket for the build status
[04:58:38.740] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:38.740] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:61:0) after 1m0s
[04:59:38.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:61:0)
[04:59:38.757] Timer tick, asking Buildbucket for the build status
[04:59:38.820] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:38.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:62:0) after 1m0s
[05:00:38.845] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:62:0)
[05:00:38.845] Timer tick, asking Buildbucket for the build status
[05:00:38.893] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:38.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:63:0) after 1m0s
[05:01:38.922] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:63:0)
[05:01:38.922] Timer tick, asking Buildbucket for the build status
[05:01:39.074] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:39.074] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:64:0) after 1m0s
[05:02:39.096] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:64:0)
[05:02:39.096] Timer tick, asking Buildbucket for the build status
[05:02:39.275] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:39.275] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:65:0) after 1m0s
[05:03:39.291] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:65:0)
[05:03:39.291] Timer tick, asking Buildbucket for the build status
[05:03:39.379] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:39.379] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:66:0) after 1m0s
[05:04:39.403] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:66:0)
[05:04:39.403] Timer tick, asking Buildbucket for the build status
[05:04:39.461] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:39.461] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:67:0) after 1m0s
[05:05:39.490] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:67:0)
[05:05:39.490] Timer tick, asking Buildbucket for the build status
[05:05:39.543] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:39.543] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:68:0) after 1m0s
[05:06:39.618] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:68:0)
[05:06:39.618] Timer tick, asking Buildbucket for the build status
[05:06:39.683] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:39.683] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:69:0) after 1m0s
[05:07:39.708] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:69:0)
[05:07:39.708] Timer tick, asking Buildbucket for the build status
[05:07:39.759] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:39.759] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:70:0) after 1m0s
[05:08:39.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:70:0)
[05:08:39.777] Timer tick, asking Buildbucket for the build status
[05:08:39.841] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:39.841] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:71:0) after 1m0s
[05:09:39.857] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:71:0)
[05:09:39.857] Timer tick, asking Buildbucket for the build status
[05:09:39.903] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:39.903] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:72:0) after 1m0s
[05:10:39.924] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:72:0)
[05:10:39.924] Timer tick, asking Buildbucket for the build status
[05:10:40.181] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:40.181] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:73:0) after 1m0s
[05:11:40.198] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:73:0)
[05:11:40.198] Timer tick, asking Buildbucket for the build status
[05:11:40.412] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:40.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:74:0) after 1m0s
[05:12:40.431] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:74:0)
[05:12:40.431] Timer tick, asking Buildbucket for the build status
[05:12:40.527] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:40.527] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:75:0) after 1m0s
[05:13:40.545] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:75:0)
[05:13:40.545] Timer tick, asking Buildbucket for the build status
[05:13:40.621] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:40.621] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:76:0) after 1m0s
[05:14:40.639] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:76:0)
[05:14:40.639] Timer tick, asking Buildbucket for the build status
[05:14:40.689] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:40.689] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:77:0) after 1m0s
[05:15:40.745] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:77:0)
[05:15:40.745] Timer tick, asking Buildbucket for the build status
[05:15:40.826] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:40.826] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:78:0) after 1m0s
[05:16:40.994] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:78:0)
[05:16:40.994] Timer tick, asking Buildbucket for the build status
[05:16:41.069] Build 8920763038446547728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:41.069] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9086193100499421824:79:0) after 1m0s
[05:17:16.890] Received PubSub notification, asking Buildbucket for the build status
[05:17:17.027] Build 8920763038446547728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:17:17.027] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1550899036095147",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550894429695356",
"id": "8920763038446547728",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-android\", \"properties\": {\"root_solution_revision\": \"883bce6f15273bc4adadb62393b115a5aaed2564\", \"root_solution_revision_timestamp\": 1550894234}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"codesearch-gen-chromium-android\"], \"kvm\": [\"1\"], \"id\": [\"swarm1882-c4\"], \"server_version\": [\"4120-35fcaef\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.infra.codesearch\"], \"caches\": [\"builder_4d14e380d83a89b4cb58aa2f3c73d8f515800858510b279900319844ebd58b92_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"got_nacl_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26820}\", \"got_swarming_client_revision\": \"d50a88f50782ba29076061b94c7b9d08a6c7e424\", \"got_revision\": \"883bce6f15273bc4adadb62393b115a5aaed2564\", \"recipe\": \"chromium_codesearch\", \"got_dawn_revision\": \"87bf834109fd5d372e62901101f285d4fb65fe67\", \"got_clang_revision\": \"353250-1\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1550894234, \"got_revision_cp\": \"refs/heads/master@{#634936}\", \"root_solution_revision\": \"883bce6f15273bc4adadb62393b115a5aaed2564\", \"buildername\": \"codesearch-gen-chromium-android\", \"got_webrtc_revision\": \"487c09bb73c18fd7ae8c2efc746531422c324c1f\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"f78131dac0763e4c2d1310a9560cbd311e5dea64\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550894429695356, \"tags\": [\"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/4382\", \"builder:codesearch-gen-chromium-android\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:7631\", \"scheduler_invocation_id:9086193100499421824\", \"scheduler_job_id:infra/codesearch-gen-chromium-android\", \"user_agent:luci-scheduler\", \"user_agent:recipe\"], \"bucket\": \"luci.infra.codesearch\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"infra\", \"id\": \"8920763038446547728\"}}, \"got_v8_revision\": \"6b0fdfceb1d6b3c73a1e84d510307ef965601465\", \"got_v8_revision_cp\": \"refs/heads/7.4.206@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 4382, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"codesearch-gen-chromium-android\", \"key\": \"builder\"}, {\"value\": \"codesearch-gen-chromium-initiator\", \"key\": \"parent_buildername\"}, {\"value\": \"7631\", \"key\": \"parent_buildnumber\"}, {\"value\": \"9086193100499421824\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"infra/codesearch-gen-chromium-android\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}, {\"value\": \"recipe\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"infra\", \"builder\": \"codesearch-gen-chromium-android\", \"bucket\": \"codesearch\"}, \"number\": 4382, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"8b9d00ab4b5db6237327191cf61f2fdd41374b9f\"}, \"recipe\": {\"name\": \"chromium_codesearch\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8920763038446547728\", \"input\": {}, \"createTime\": \"2019-02-23T04:00:29.695356Z\"}}, \"path_config\": \"generic\", \"bot_id\": \"swarm1882-c4\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1550894444595173",
"status": "COMPLETED",
"status_changed_ts": "1550899036552993",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/4382",
"builder:codesearch-gen-chromium-android",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:7631",
"scheduler_invocation_id:9086193100499421824",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8920763038446547728/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4331547f83387210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1550899036554761",
"url": "https://ci.chromium.org/b/8920763038446547728",
"utcnow_ts": "1550899036976942"
}
}
[05:17:17.028] Invocation finished in 1h16m48.673508726s with status SUCCEEDED