Status: FAILED
Triggered by: -
Duration: 3 hours
Actions:

Definition (rev 4a2f121d23f9adfa08cce385d9356b05a0d1b7b6)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.nacl.toolchain"
  builder: "linux-pnacl-x86_64-tests-x86_64"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/native_client/src/native_client",
  "revision": "d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28"
}

Incoming tags

  • buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[23:45:23.115] New invocation is queued and will start shortly
[23:45:24.344] Starting the invocation (attempt 1)
[23:45:24.393] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28"
[23:45:24.393] Popped gitiles commit info from properties and tags
[23:45:24.393] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:45:24.395] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:45:24.395] Buildbucket request:
{
  "requestId": "9007117997559058848",
  "builder": {
    "project": "nacl",
    "bucket": "toolchain",
    "builder": "linux-pnacl-x86_64-tests-x86_64"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/master",
                              "repo": "https://chromium.googlesource.com/native_client/src/native_client",
                              "revision": "d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/master@d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28",
                        "title": "d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9007117997559058848"
    },
    {
      "key": "scheduler_job_id",
      "value": "nacl/linux-pnacl-x86_64-tests-x86_64"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[23:45:25.970] Scheduled build:
{
  "id": "8841687935256544368",
  "builder": {
    "project": "nacl",
    "bucket": "toolchain",
    "builder": "linux-pnacl-x86_64-tests-x86_64"
  },
  "number": 5182,
  "createdBy": "project:nacl",
  "createTime": "2021-07-14T23:45:24.674586Z",
  "updateTime": "2021-07-14T23:45:25.746530Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28",
      "ref": "refs/heads/master"
    }
  },
  "canary": true
}
[23:45:25.970] Task URL: https://cr-buildbucket.appspot.com/build/8841687935256544368
[23:45:25.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:2:0) after 2m44s
[23:48:10.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:2:0)
[23:48:10.148] Build status: SCHEDULED
[23:48:10.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:3:0) after 8m43s
[23:56:53.509] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:3:0)
[23:56:53.538] Build status: SCHEDULED
[23:56:53.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:4:0) after 5m37s
[00:02:30.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:4:0)
[00:02:30.633] Build status: SCHEDULED
[00:02:30.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:5:0) after 2m11s
[00:04:41.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:5:0)
[00:04:41.720] Build status: SCHEDULED
[00:04:41.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:6:0) after 6m54s
[00:11:35.713] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:6:0)
[00:11:35.769] Build status: SCHEDULED
[00:11:35.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:7:0) after 7m45s
[00:19:21.171] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:7:0)
[00:19:21.200] Build status: SCHEDULED
[00:19:21.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:8:0) after 5m13s
[00:24:34.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:8:0)
[00:24:34.247] Build status: SCHEDULED
[00:24:34.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:9:0) after 3m10s
[00:27:44.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:9:0)
[00:27:44.276] Build status: SCHEDULED
[00:27:44.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:10:0) after 3m11s
[00:30:55.352] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:10:0)
[00:30:55.382] Build status: SCHEDULED
[00:30:55.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:11:0) after 4m43s
[00:35:38.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:11:0)
[00:35:38.448] Build status: SCHEDULED
[00:35:38.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:12:0) after 9m47s
[00:45:25.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:12:0)
[00:45:25.531] Build status: SCHEDULED
[00:45:25.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:13:0) after 8m25s
[00:53:50.596] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:13:0)
[00:53:50.631] Build status: SCHEDULED
[00:53:50.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:14:0) after 2m53s
[00:56:43.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:14:0)
[00:56:43.791] Build status: SCHEDULED
[00:56:43.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:15:0) after 6m32s
[01:03:16.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:15:0)
[01:03:16.113] Build status: SCHEDULED
[01:03:16.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:16:0) after 7m42s
[01:10:01.820] Received PubSub notification, asking Buildbucket for the build status
[01:10:01.849] Build status: STARTED
[01:10:58.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:16:0)
[01:10:58.171] Build status: STARTED
[01:10:58.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:18:0) after 6m37s
[01:17:35.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:18:0)
[01:17:35.228] Build status: STARTED
[01:17:35.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:19:0) after 8m15s
[01:25:50.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:19:0)
[01:25:50.406] Build status: STARTED
[01:25:50.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:20:0) after 5m20s
[01:31:10.451] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:20:0)
[01:31:10.558] Build status: STARTED
[01:31:10.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:21:0) after 2m58s
[01:34:08.575] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:21:0)
[01:34:08.634] Build status: STARTED
[01:34:08.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:22:0) after 3m44s
[01:37:52.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:22:0)
[01:37:52.883] Build status: STARTED
[01:37:52.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:23:0) after 4m6s
[01:41:58.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:23:0)
[01:41:58.998] Build status: STARTED
[01:41:58.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:24:0) after 6m39s
[01:48:38.337] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:24:0)
[01:48:38.543] Build status: STARTED
[01:48:38.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:25:0) after 1m10s
[01:49:48.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:25:0)
[01:49:48.589] Build status: STARTED
[01:49:48.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:26:0) after 1m59s
[01:51:47.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:26:0)
[01:51:47.747] Build status: STARTED
[01:51:47.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:27:0) after 8m25s
[02:00:13.000] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:27:0)
[02:00:13.035] Build status: STARTED
[02:00:13.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:28:0) after 8m35s
[02:08:48.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:28:0)
[02:08:48.173] Build status: STARTED
[02:08:48.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:29:0) after 4m18s
[02:13:06.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:29:0)
[02:13:06.423] Build status: STARTED
[02:13:06.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:30:0) after 8m35s
[02:21:41.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:30:0)
[02:21:41.674] Build status: STARTED
[02:21:41.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:31:0) after 6m55s
[02:28:36.776] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:31:0)
[02:28:36.853] Build status: STARTED
[02:28:36.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:32:0) after 3m54s
[02:32:30.873] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:32:0)
[02:32:30.907] Build status: STARTED
[02:32:30.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:33:0) after 7m54s
[02:40:24.933] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:33:0)
[02:40:25.062] Build status: STARTED
[02:40:25.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:34:0) after 2m22s
[02:42:47.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:34:0)
[02:42:47.410] Build status: STARTED
[02:42:47.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:35:0) after 9m39s
[02:52:26.463] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:35:0)
[02:52:26.494] Build status: STARTED
[02:52:26.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:36:0) after 6m16s
[02:58:42.564] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:36:0)
[02:58:42.591] Build status: STARTED
[02:58:42.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:37:0) after 8m34s
[03:07:16.793] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:37:0)
[03:07:16.826] Build status: STARTED
[03:07:16.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:38:0) after 4m8s
[03:11:24.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:38:0)
[03:11:24.985] Build status: STARTED
[03:11:24.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:39:0) after 1m26s
[03:12:51.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:39:0)
[03:12:51.045] Build status: STARTED
[03:12:51.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:40:0) after 9m55s
[03:22:46.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:40:0)
[03:22:46.397] Build status: STARTED
[03:22:46.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:41:0) after 6m47s
[03:29:33.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:41:0)
[03:29:33.589] Build status: STARTED
[03:29:33.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9007117997559058848:42:0) after 7m26s
[03:35:58.413] Received PubSub notification, asking Buildbucket for the build status
[03:35:58.444] Build:
{
  "id": "8841687935256544368",
  "builder": {
    "project": "nacl",
    "bucket": "toolchain",
    "builder": "linux-pnacl-x86_64-tests-x86_64"
  },
  "number": 5182,
  "createdBy": "project:nacl",
  "createTime": "2021-07-14T23:45:24.674586Z",
  "startTime": "2021-07-15T01:09:59.926722Z",
  "endTime": "2021-07-15T03:35:58.111383565Z",
  "updateTime": "2021-07-15T03:35:58.111797984Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "d9b3fa4b519b8b2ad6ca9ea544d787f833e32a28",
      "ref": "refs/heads/master"
    }
  },
  "canary": true
}
[03:35:58.444] Invocation finished in 3h50m35.348078825s with status FAILED