Status: SUCCEEDED
Triggered by: -
Duration: 57 minutes
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": "0e8c8b50647759120e2b1fde023968e29e13284c"
}

Incoming tags

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

Debug log (UTC)

[01:29:26.626] New invocation is queued and will start shortly
[01:29:28.490] Starting the invocation (attempt 1)
[01:29:28.529] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:28.529] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:28.529] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9072522460509461824",
  "parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"0e8c8b50647759120e2b1fde023968e29e13284c\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Deterministic Linux (dbg)",
    "scheduler_invocation_id:9072522460509461824",
    "scheduler_job_id:chromium/Deterministic Linux (dbg)",
    "user_agent:luci-scheduler",
    "buildset:commit/git/0e8c8b50647759120e2b1fde023968e29e13284c",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e8c8b50647759120e2b1fde023968e29e13284c",
    "gitiles_ref:refs/heads/master"
  ]
}
[01:29:29.206] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1563931768683443",
    "id": "8907092397679814896",
    "parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0e8c8b50647759120e2b1fde023968e29e13284c\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1563931769105005",
    "tags": [
      "build_address:luci.chromium.ci/Deterministic Linux (dbg)/9548",
      "builder:Deterministic Linux (dbg)",
      "buildset:commit/git/0e8c8b50647759120e2b1fde023968e29e13284c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e8c8b50647759120e2b1fde023968e29e13284c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9072522460509461824",
      "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/8907092397679814896/+/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": "1563931769105095",
    "url": "https://ci.chromium.org/b/8907092397679814896",
    "utcnow_ts": "1563931769196700"
  }
}
[01:29:29.206] Task URL: https://ci.chromium.org/b/8907092397679814896
[01:29:29.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:2:0) after 1m0s
[01:29:33.331] Received PubSub notification, asking Buildbucket for the build status
[01:29:33.499] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:29.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:2:0)
[01:30:29.303] Timer tick, asking Buildbucket for the build status
[01:30:29.577] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:29.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:4:0) after 1m0s
[01:31:29.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:4:0)
[01:31:29.642] Timer tick, asking Buildbucket for the build status
[01:31:30.451] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:30.451] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:5:0) after 1m0s
[01:32:30.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:5:0)
[01:32:30.611] Timer tick, asking Buildbucket for the build status
[01:32:30.866] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:30.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:6:0) after 1m0s
[01:33:30.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:6:0)
[01:33:30.970] Timer tick, asking Buildbucket for the build status
[01:33:31.205] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:31.205] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:7:0) after 1m0s
[01:34:31.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:7:0)
[01:34:31.260] Timer tick, asking Buildbucket for the build status
[01:34:31.557] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:31.557] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:8:0) after 1m0s
[01:35:31.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:8:0)
[01:35:31.590] Timer tick, asking Buildbucket for the build status
[01:35:32.867] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:32.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:9:0) after 1m0s
[01:36:32.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:9:0)
[01:36:32.954] Timer tick, asking Buildbucket for the build status
[01:36:33.116] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:33.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:10:0) after 1m0s
[01:37:33.141] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:10:0)
[01:37:33.141] Timer tick, asking Buildbucket for the build status
[01:37:33.330] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:33.330] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:11:0) after 1m0s
[01:38:33.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:11:0)
[01:38:33.379] Timer tick, asking Buildbucket for the build status
[01:38:33.594] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:33.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:12:0) after 1m0s
[01:39:33.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:12:0)
[01:39:33.616] Timer tick, asking Buildbucket for the build status
[01:39:33.844] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:33.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:13:0) after 1m0s
[01:40:33.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:13:0)
[01:40:33.874] Timer tick, asking Buildbucket for the build status
[01:40:34.143] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:34.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:14:0) after 1m0s
[01:41:34.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:14:0)
[01:41:34.212] Timer tick, asking Buildbucket for the build status
[01:41:34.467] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:34.467] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:15:0) after 1m0s
[01:42:34.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:15:0)
[01:42:34.525] Timer tick, asking Buildbucket for the build status
[01:42:34.754] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:34.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:16:0) after 1m0s
[01:43:34.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:16:0)
[01:43:34.787] Timer tick, asking Buildbucket for the build status
[01:43:34.966] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:34.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:17:0) after 1m0s
[01:44:34.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:17:0)
[01:44:34.994] Timer tick, asking Buildbucket for the build status
[01:44:35.238] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:35.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:18:0) after 1m0s
[01:45:35.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:18:0)
[01:45:35.408] Timer tick, asking Buildbucket for the build status
[01:45:36.059] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:36.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:19:0) after 1m0s
[01:46:36.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:19:0)
[01:46:36.099] Timer tick, asking Buildbucket for the build status
[01:46:36.374] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:36.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:20:0) after 1m0s
[01:47:36.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:20:0)
[01:47:36.496] Timer tick, asking Buildbucket for the build status
[01:47:38.318] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:21:0) after 1m0s
[01:48:38.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:21:0)
[01:48:38.364] Timer tick, asking Buildbucket for the build status
[01:48:38.839] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:38.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:22:0) after 1m0s
[01:49:38.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:22:0)
[01:49:38.839] Timer tick, asking Buildbucket for the build status
[01:49:40.250] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:40.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:23:0) after 1m0s
[01:50:40.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:23:0)
[01:50:40.290] Timer tick, asking Buildbucket for the build status
[01:50:40.433] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:40.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:24:0) after 1m0s
[01:51:40.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:24:0)
[01:51:40.521] Timer tick, asking Buildbucket for the build status
[01:51:41.156] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:41.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:25:0) after 1m0s
[01:52:41.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:25:0)
[01:52:41.180] Timer tick, asking Buildbucket for the build status
[01:52:43.558] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:43.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:26:0) after 1m0s
[01:53:43.565] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:26:0)
[01:53:43.565] Timer tick, asking Buildbucket for the build status
[01:53:43.846] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:43.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:27:0) after 1m0s
[01:54:43.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:27:0)
[01:54:43.910] Timer tick, asking Buildbucket for the build status
[01:54:44.123] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:44.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:28:0) after 1m0s
[01:55:44.171] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:28:0)
[01:55:44.171] Timer tick, asking Buildbucket for the build status
[01:55:44.566] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:44.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:29:0) after 1m0s
[01:56:44.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:29:0)
[01:56:44.595] Timer tick, asking Buildbucket for the build status
[01:56:44.754] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:30:0) after 1m0s
[01:57:44.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:30:0)
[01:57:44.780] Timer tick, asking Buildbucket for the build status
[01:57:45.294] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:45.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:31:0) after 1m0s
[01:58:45.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:31:0)
[01:58:45.343] Timer tick, asking Buildbucket for the build status
[01:58:46.240] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:46.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:32:0) after 1m0s
[01:59:46.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:32:0)
[01:59:46.267] Timer tick, asking Buildbucket for the build status
[01:59:46.488] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:46.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:33:0) after 1m0s
[02:00:46.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:33:0)
[02:00:46.556] Timer tick, asking Buildbucket for the build status
[02:00:46.722] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:46.722] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:34:0) after 1m0s
[02:01:46.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:34:0)
[02:01:46.755] Timer tick, asking Buildbucket for the build status
[02:01:47.535] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:47.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:35:0) after 1m0s
[02:02:47.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:35:0)
[02:02:47.638] Timer tick, asking Buildbucket for the build status
[02:02:49.290] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:49.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:36:0) after 1m0s
[02:03:49.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:36:0)
[02:03:49.372] Timer tick, asking Buildbucket for the build status
[02:03:49.545] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:49.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:37:0) after 1m0s
[02:04:49.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:37:0)
[02:04:49.572] Timer tick, asking Buildbucket for the build status
[02:04:50.567] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:50.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:38:0) after 1m0s
[02:05:50.620] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:38:0)
[02:05:50.620] Timer tick, asking Buildbucket for the build status
[02:05:51.092] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:51.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:39:0) after 1m0s
[02:06:51.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:39:0)
[02:06:51.152] Timer tick, asking Buildbucket for the build status
[02:06:51.330] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:51.330] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:40:0) after 1m0s
[02:07:51.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:40:0)
[02:07:51.391] Timer tick, asking Buildbucket for the build status
[02:07:52.010] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:52.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:41:0) after 1m0s
[02:08:52.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:41:0)
[02:08:52.055] Timer tick, asking Buildbucket for the build status
[02:08:52.296] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:52.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:42:0) after 1m0s
[02:09:52.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:42:0)
[02:09:52.360] Timer tick, asking Buildbucket for the build status
[02:09:52.491] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:52.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:43:0) after 1m0s
[02:10:52.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:43:0)
[02:10:52.514] Timer tick, asking Buildbucket for the build status
[02:10:53.023] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:53.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:44:0) after 1m0s
[02:11:53.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:44:0)
[02:11:53.045] Timer tick, asking Buildbucket for the build status
[02:11:53.191] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:53.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:45:0) after 1m0s
[02:12:53.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:45:0)
[02:12:53.273] Timer tick, asking Buildbucket for the build status
[02:12:53.717] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:53.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:46:0) after 1m0s
[02:13:53.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:46:0)
[02:13:53.809] Timer tick, asking Buildbucket for the build status
[02:13:54.912] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:54.912] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:47:0) after 1m0s
[02:14:54.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:47:0)
[02:14:54.943] Timer tick, asking Buildbucket for the build status
[02:14:55.482] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:55.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:48:0) after 1m0s
[02:15:55.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:48:0)
[02:15:55.551] Timer tick, asking Buildbucket for the build status
[02:15:56.247] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:56.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:49:0) after 1m0s
[02:16:56.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:49:0)
[02:16:56.231] Timer tick, asking Buildbucket for the build status
[02:16:56.445] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:56.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:50:0) after 1m0s
[02:17:56.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:50:0)
[02:17:56.524] Timer tick, asking Buildbucket for the build status
[02:17:56.828] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:56.828] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:51:0) after 1m0s
[02:18:56.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:51:0)
[02:18:56.876] Timer tick, asking Buildbucket for the build status
[02:18:57.168] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:57.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:52:0) after 1m0s
[02:19:57.434] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:52:0)
[02:19:57.434] Timer tick, asking Buildbucket for the build status
[02:19:57.568] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:57.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:53:0) after 1m0s
[02:20:57.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:53:0)
[02:20:57.680] Timer tick, asking Buildbucket for the build status
[02:20:58.604] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:58.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:54:0) after 1m0s
[02:21:58.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:54:0)
[02:21:58.669] Timer tick, asking Buildbucket for the build status
[02:21:58.837] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:58.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:55:0) after 1m0s
[02:22:58.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:55:0)
[02:22:58.867] Timer tick, asking Buildbucket for the build status
[02:22:59.348] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:59.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:56:0) after 1m0s
[02:23:59.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:56:0)
[02:23:59.446] Timer tick, asking Buildbucket for the build status
[02:23:59.615] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:59.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:57:0) after 1m0s
[02:24:59.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:57:0)
[02:24:59.619] Timer tick, asking Buildbucket for the build status
[02:25:00.315] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:00.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:58:0) after 1m0s
[02:26:00.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:58:0)
[02:26:00.403] Timer tick, asking Buildbucket for the build status
[02:26:00.569] Build 8907092397679814896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:00.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9072522460509461824:59:0) after 1m0s
[02:26:58.819] Received PubSub notification, asking Buildbucket for the build status
[02:26:59.142] Build 8907092397679814896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:26:59.142] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1563935217561874",
    "created_by": "project:chromium",
    "created_ts": "1563931768683443",
    "id": "8907092397679814896",
    "parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0e8c8b50647759120e2b1fde023968e29e13284c\"}}",
    "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-32-0-b6an\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 9548, \"got_angle_revision\": \"8bb46c5b9ffc89e3d5eeddcd990fd69bb4cbeecd\", \"got_dawn_revision\": \"8944f0205b04fa5fe396e6f5e4c9298370f96acb\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"0e8c8b50647759120e2b1fde023968e29e13284c\", \"got_revision_cp\": \"refs/heads/master@{#680272}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"4035531228d69a8e3ec475ef75b51db302e70473\", \"got_v8_revision_cp\": \"refs/heads/7.7.299@{#1}\", \"got_webrtc_revision\": \"cfefa0aef329aac0206c5e56efd90b3b0bdb88b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28646}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0e8c8b50647759120e2b1fde023968e29e13284c\"}, \"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-xenial-32-0-b6an\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1563931771792886",
    "status": "COMPLETED",
    "status_changed_ts": "1563935217893212",
    "tags": [
      "build_address:luci.chromium.ci/Deterministic Linux (dbg)/9548",
      "builder:Deterministic Linux (dbg)",
      "buildset:commit/git/0e8c8b50647759120e2b1fde023968e29e13284c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e8c8b50647759120e2b1fde023968e29e13284c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9072522460509461824",
      "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/8907092397679814896/+/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:463a6a81dd69ea10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1563935217898761",
    "url": "https://ci.chromium.org/b/8907092397679814896",
    "utcnow_ts": "1563935219132666"
  }
}
[02:26:59.142] Invocation finished in 57m32.54156856s with status SUCCEEDED