Status: SUCCEEDED
Triggered by: -
Duration: 1 hour
Actions:

Definition (rev 4c3247f4ed8a00ea6dc37d6edf987ff8d0e003c5)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "Deterministic Linux (dbg)"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/chromium/src.git",
  "revision": "4d25b125dae5d2dba69980cae000751efe34b17a"
}

Incoming tags

  • buildset:commit/git/4d25b125dae5d2dba69980cae000751efe34b17a
  • buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d25b125dae5d2dba69980cae000751efe34b17a
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[02:36:12.353] New invocation is queued and will start shortly
[02:36:13.440] Starting the invocation (attempt 1)
[02:36:13.479] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:36:13.479] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:36:13.479] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9072971245023563504",
  "parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4d25b125dae5d2dba69980cae000751efe34b17a\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Deterministic Linux (dbg)",
    "scheduler_invocation_id:9072971245023563504",
    "scheduler_job_id:chromium/Deterministic Linux (dbg)",
    "user_agent:luci-scheduler",
    "buildset:commit/git/4d25b125dae5d2dba69980cae000751efe34b17a",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d25b125dae5d2dba69980cae000751efe34b17a",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:36:14.082] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1563503773615576",
    "id": "8907541183035854448",
    "parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4d25b125dae5d2dba69980cae000751efe34b17a\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1563503773922325",
    "tags": [
      "build_address:luci.chromium.ci/Deterministic Linux (dbg)/9443",
      "builder:Deterministic Linux (dbg)",
      "buildset:commit/git/4d25b125dae5d2dba69980cae000751efe34b17a",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d25b125dae5d2dba69980cae000751efe34b17a",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9072971245023563504",
      "scheduler_job_id:chromium/Deterministic Linux (dbg)",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8907541183035854448/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1563503773922414",
    "url": "https://ci.chromium.org/b/8907541183035854448",
    "utcnow_ts": "1563503774075003"
  }
}
[02:36:14.082] Task URL: https://ci.chromium.org/b/8907541183035854448
[02:36:14.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:2:0) after 1m0s
[02:36:20.696] Received PubSub notification, asking Buildbucket for the build status
[02:36:20.808] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:14.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:2:0)
[02:37:14.168] Timer tick, asking Buildbucket for the build status
[02:37:15.182] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:15.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:4:0) after 1m0s
[02:38:15.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:4:0)
[02:38:15.219] Timer tick, asking Buildbucket for the build status
[02:38:15.342] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:15.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:5:0) after 1m0s
[02:39:15.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:5:0)
[02:39:15.407] Timer tick, asking Buildbucket for the build status
[02:39:15.512] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:15.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:6:0) after 1m0s
[02:40:15.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:6:0)
[02:40:15.557] Timer tick, asking Buildbucket for the build status
[02:40:16.175] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:16.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:7:0) after 1m0s
[02:41:16.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:7:0)
[02:41:16.207] Timer tick, asking Buildbucket for the build status
[02:41:17.082] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:17.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:8:0) after 1m0s
[02:42:17.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:8:0)
[02:42:17.138] Timer tick, asking Buildbucket for the build status
[02:42:17.426] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:17.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:9:0) after 1m0s
[02:43:17.529] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:9:0)
[02:43:17.529] Timer tick, asking Buildbucket for the build status
[02:43:20.885] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:20.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:10:0) after 1m0s
[02:44:20.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:10:0)
[02:44:20.920] Timer tick, asking Buildbucket for the build status
[02:44:21.046] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:21.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:11:0) after 1m0s
[02:45:21.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:11:0)
[02:45:21.058] Timer tick, asking Buildbucket for the build status
[02:45:23.105] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:23.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:12:0) after 1m0s
[02:46:23.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:12:0)
[02:46:23.285] Timer tick, asking Buildbucket for the build status
[02:46:23.615] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:23.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:13:0) after 1m0s
[02:47:23.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:13:0)
[02:47:23.728] Timer tick, asking Buildbucket for the build status
[02:47:23.853] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:23.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:14:0) after 1m0s
[02:48:23.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:14:0)
[02:48:23.882] Timer tick, asking Buildbucket for the build status
[02:48:24.713] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:15:0) after 1m0s
[02:49:24.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:15:0)
[02:49:24.766] Timer tick, asking Buildbucket for the build status
[02:49:25.063] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:25.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:16:0) after 1m0s
[02:50:25.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:16:0)
[02:50:25.142] Timer tick, asking Buildbucket for the build status
[02:50:25.320] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:17:0) after 1m0s
[02:51:25.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:17:0)
[02:51:25.359] Timer tick, asking Buildbucket for the build status
[02:51:25.560] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:25.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:18:0) after 1m0s
[02:52:25.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:18:0)
[02:52:25.583] Timer tick, asking Buildbucket for the build status
[02:52:25.703] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:25.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:19:0) after 1m0s
[02:53:25.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:19:0)
[02:53:25.777] Timer tick, asking Buildbucket for the build status
[02:53:25.938] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:25.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:20:0) after 1m0s
[02:54:26.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:20:0)
[02:54:26.052] Timer tick, asking Buildbucket for the build status
[02:54:26.719] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:26.719] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:21:0) after 1m0s
[02:55:26.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:21:0)
[02:55:26.776] Timer tick, asking Buildbucket for the build status
[02:55:26.986] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:22:0) after 1m0s
[02:56:27.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:22:0)
[02:56:27.146] Timer tick, asking Buildbucket for the build status
[02:56:27.348] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:27.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:23:0) after 1m0s
[02:57:27.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:23:0)
[02:57:27.444] Timer tick, asking Buildbucket for the build status
[02:57:28.129] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:28.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:24:0) after 1m0s
[02:58:28.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:24:0)
[02:58:28.176] Timer tick, asking Buildbucket for the build status
[02:58:28.394] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:28.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:25:0) after 1m0s
[02:59:28.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:25:0)
[02:59:28.453] Timer tick, asking Buildbucket for the build status
[02:59:29.174] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:29.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:26:0) after 1m0s
[03:00:29.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:26:0)
[03:00:29.306] Timer tick, asking Buildbucket for the build status
[03:00:32.331] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:32.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:27:0) after 1m0s
[03:01:32.369] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:27:0)
[03:01:32.369] Timer tick, asking Buildbucket for the build status
[03:01:32.544] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:32.544] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:28:0) after 1m0s
[03:02:32.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:28:0)
[03:02:32.611] Timer tick, asking Buildbucket for the build status
[03:02:33.227] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:33.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:29:0) after 1m0s
[03:03:33.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:29:0)
[03:03:33.233] Timer tick, asking Buildbucket for the build status
[03:03:33.687] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:33.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:30:0) after 1m0s
[03:04:33.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:30:0)
[03:04:33.751] Timer tick, asking Buildbucket for the build status
[03:04:34.382] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:34.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:31:0) after 1m0s
[03:05:34.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:31:0)
[03:05:34.418] Timer tick, asking Buildbucket for the build status
[03:05:36.013] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:36.014] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:32:0) after 1m0s
[03:06:36.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:32:0)
[03:06:36.048] Timer tick, asking Buildbucket for the build status
[03:06:36.848] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:36.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:33:0) after 1m0s
[03:07:36.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:33:0)
[03:07:36.904] Timer tick, asking Buildbucket for the build status
[03:07:38.043] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:38.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:34:0) after 1m0s
[03:08:38.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:34:0)
[03:08:38.097] Timer tick, asking Buildbucket for the build status
[03:08:38.300] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:38.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:35:0) after 1m0s
[03:09:38.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:35:0)
[03:09:38.335] Timer tick, asking Buildbucket for the build status
[03:09:39.386] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:39.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:36:0) after 1m0s
[03:10:39.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:36:0)
[03:10:39.442] Timer tick, asking Buildbucket for the build status
[03:10:39.590] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:39.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:37:0) after 1m0s
[03:11:39.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:37:0)
[03:11:39.622] Timer tick, asking Buildbucket for the build status
[03:11:40.229] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:40.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:38:0) after 1m0s
[03:12:40.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:38:0)
[03:12:40.254] Timer tick, asking Buildbucket for the build status
[03:12:42.945] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:42.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:39:0) after 1m0s
[03:13:42.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:39:0)
[03:13:42.974] Timer tick, asking Buildbucket for the build status
[03:13:43.173] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:43.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:40:0) after 1m0s
[03:14:43.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:40:0)
[03:14:43.188] Timer tick, asking Buildbucket for the build status
[03:14:44.324] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:44.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:41:0) after 1m0s
[03:15:44.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:41:0)
[03:15:44.399] Timer tick, asking Buildbucket for the build status
[03:15:44.564] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:44.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:42:0) after 1m0s
[03:16:44.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:42:0)
[03:16:44.794] Timer tick, asking Buildbucket for the build status
[03:16:45.060] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:45.060] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:43:0) after 1m0s
[03:17:45.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:43:0)
[03:17:45.134] Timer tick, asking Buildbucket for the build status
[03:17:45.600] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:45.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:44:0) after 1m0s
[03:18:45.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:44:0)
[03:18:45.675] Timer tick, asking Buildbucket for the build status
[03:18:48.197] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:48.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:45:0) after 1m0s
[03:19:48.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:45:0)
[03:19:48.250] Timer tick, asking Buildbucket for the build status
[03:19:48.484] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:48.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:46:0) after 1m0s
[03:20:48.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:46:0)
[03:20:48.516] Timer tick, asking Buildbucket for the build status
[03:20:48.736] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:48.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:47:0) after 1m0s
[03:21:48.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:47:0)
[03:21:48.848] Timer tick, asking Buildbucket for the build status
[03:21:49.335] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:49.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:48:0) after 1m0s
[03:22:49.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:48:0)
[03:22:49.431] Timer tick, asking Buildbucket for the build status
[03:22:50.028] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:50.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:49:0) after 1m0s
[03:23:50.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:49:0)
[03:23:50.059] Timer tick, asking Buildbucket for the build status
[03:23:50.707] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:50.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:50:0) after 1m0s
[03:24:50.797] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:50:0)
[03:24:50.797] Timer tick, asking Buildbucket for the build status
[03:24:51.097] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:51.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:51:0) after 1m0s
[03:25:51.209] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:51:0)
[03:25:51.209] Timer tick, asking Buildbucket for the build status
[03:25:51.368] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:51.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:52:0) after 1m0s
[03:26:51.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:52:0)
[03:26:51.382] Timer tick, asking Buildbucket for the build status
[03:26:51.668] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:51.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:53:0) after 1m0s
[03:27:51.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:53:0)
[03:27:51.668] Timer tick, asking Buildbucket for the build status
[03:27:52.855] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:52.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:54:0) after 1m0s
[03:28:52.893] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:54:0)
[03:28:52.893] Timer tick, asking Buildbucket for the build status
[03:28:53.083] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:53.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:55:0) after 1m0s
[03:29:53.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:55:0)
[03:29:53.178] Timer tick, asking Buildbucket for the build status
[03:29:53.311] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:53.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:56:0) after 1m0s
[03:30:53.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:56:0)
[03:30:53.391] Timer tick, asking Buildbucket for the build status
[03:30:53.533] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:53.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:57:0) after 1m0s
[03:31:53.620] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:57:0)
[03:31:53.620] Timer tick, asking Buildbucket for the build status
[03:31:53.797] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:58:0) after 1m0s
[03:32:53.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:58:0)
[03:32:53.824] Timer tick, asking Buildbucket for the build status
[03:32:54.846] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:54.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:59:0) after 1m0s
[03:33:54.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:59:0)
[03:33:54.973] Timer tick, asking Buildbucket for the build status
[03:33:55.119] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:55.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:60:0) after 1m0s
[03:34:55.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:60:0)
[03:34:55.126] Timer tick, asking Buildbucket for the build status
[03:34:55.778] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:55.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:61:0) after 1m0s
[03:35:55.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:61:0)
[03:35:55.788] Timer tick, asking Buildbucket for the build status
[03:35:56.438] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:56.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:62:0) after 1m0s
[03:36:56.593] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:62:0)
[03:36:56.593] Timer tick, asking Buildbucket for the build status
[03:36:56.954] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:63:0) after 1m0s
[03:37:57.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:63:0)
[03:37:57.048] Timer tick, asking Buildbucket for the build status
[03:37:57.484] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:57.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:64:0) after 1m0s
[03:38:57.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:64:0)
[03:38:57.519] Timer tick, asking Buildbucket for the build status
[03:38:58.242] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:58.242] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:65:0) after 1m0s
[03:39:58.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:65:0)
[03:39:58.337] Timer tick, asking Buildbucket for the build status
[03:39:58.540] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:58.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:66:0) after 1m0s
[03:40:58.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:66:0)
[03:40:58.625] Timer tick, asking Buildbucket for the build status
[03:40:58.740] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:58.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:67:0) after 1m0s
[03:41:58.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:67:0)
[03:41:58.820] Timer tick, asking Buildbucket for the build status
[03:41:59.236] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:59.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:68:0) after 1m0s
[03:42:59.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:68:0)
[03:42:59.240] Timer tick, asking Buildbucket for the build status
[03:43:01.145] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:01.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:69:0) after 1m0s
[03:44:01.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:69:0)
[03:44:01.238] Timer tick, asking Buildbucket for the build status
[03:44:01.542] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:01.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:70:0) after 1m0s
[03:45:01.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:70:0)
[03:45:01.607] Timer tick, asking Buildbucket for the build status
[03:45:01.889] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:01.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:71:0) after 1m0s
[03:46:01.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:71:0)
[03:46:01.933] Timer tick, asking Buildbucket for the build status
[03:46:02.117] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:02.117] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:72:0) after 1m0s
[03:47:02.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:72:0)
[03:47:02.163] Timer tick, asking Buildbucket for the build status
[03:47:05.132] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:05.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:73:0) after 1m0s
[03:48:05.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:73:0)
[03:48:05.166] Timer tick, asking Buildbucket for the build status
[03:48:05.331] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:05.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:74:0) after 1m0s
[03:49:05.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:74:0)
[03:49:05.375] Timer tick, asking Buildbucket for the build status
[03:49:05.551] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:05.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:75:0) after 1m0s
[03:50:05.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:75:0)
[03:50:05.617] Timer tick, asking Buildbucket for the build status
[03:50:05.797] Build 8907541183035854448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:05.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072971245023563504:76:0) after 1m0s
[03:50:23.398] Received PubSub notification, asking Buildbucket for the build status
[03:50:24.294] Build 8907541183035854448: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:50:24.294] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1563508221754339",
    "created_by": "project:chromium",
    "created_ts": "1563503773615576",
    "id": "8907541183035854448",
    "parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4d25b125dae5d2dba69980cae000751efe34b17a\"}}",
    "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-trusty-32-0-nujb\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 9443, \"got_angle_revision\": \"6a02f06dfd4ec5e0f9efb553059ce65535f4b312\", \"got_dawn_revision\": \"49aae0f3bde201d10f1b17d362b0d5b8f85dceb4\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"4d25b125dae5d2dba69980cae000751efe34b17a\", \"got_revision_cp\": \"refs/heads/master@{#678956}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"ad244143779fc7c11086c100d9b3e3428b990f8d\", \"got_v8_revision_cp\": \"refs/heads/7.7.276@{#1}\", \"got_webrtc_revision\": \"284c30224c2fb49580d0d702e7dec720f6ad08c2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28602}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4d25b125dae5d2dba69980cae000751efe34b17a\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-32-0-nujb\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1563503779509904",
    "status": "COMPLETED",
    "status_changed_ts": "1563508222184781",
    "tags": [
      "build_address:luci.chromium.ci/Deterministic Linux (dbg)/9443",
      "builder:Deterministic Linux (dbg)",
      "buildset:commit/git/4d25b125dae5d2dba69980cae000751efe34b17a",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d25b125dae5d2dba69980cae000751efe34b17a",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9072971245023563504",
      "scheduler_job_id:chromium/Deterministic Linux (dbg)",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8907541183035854448/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:swarming/deterministic_build",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:4620e7d37b4c5010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1563508222281515",
    "url": "https://ci.chromium.org/b/8907541183035854448",
    "utcnow_ts": "1563508224285798"
  }
}
[03:50:24.294] Invocation finished in 1h14m11.957619634s with status SUCCEEDED