Status: FAILED
Triggered by: -
Duration: 4 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": "63b3cb448cf22e589a4d125ee1829c894cb582c2"
}

Incoming tags

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

Debug log (UTC)

[18:44:34.203] New invocation is queued and will start shortly
[18:44:35.506] Starting the invocation (attempt 1)
[18:44:35.559] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/63b3cb448cf22e589a4d125ee1829c894cb582c2"
[18:44:35.559] Popped gitiles commit info from properties and tags
[18:44:35.559] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:44:35.559] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:44:35.559] Buildbucket request:
{
  "requestId": "9004056626351619808",
  "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": "63b3cb448cf22e589a4d125ee1829c894cb582c2"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/master@63b3cb448cf22e589a4d125ee1829c894cb582c2",
                        "title": "63b3cb448cf22e589a4d125ee1829c894cb582c2",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/63b3cb448cf22e589a4d125ee1829c894cb582c2"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "63b3cb448cf22e589a4d125ee1829c894cb582c2",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9004056626351619808"
    },
    {
      "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"
  }
}
[18:44:36.190] Scheduled build:
{
  "id": "8838626564121508512",
  "builder": {
    "project": "nacl",
    "bucket": "toolchain",
    "builder": "linux-pnacl-x86_64-tests-x86_64"
  },
  "number": 5200,
  "createdBy": "project:nacl",
  "createTime": "2021-08-17T18:44:35.699553Z",
  "updateTime": "2021-08-17T18:44:36.029393Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "63b3cb448cf22e589a4d125ee1829c894cb582c2",
      "ref": "refs/heads/master"
    }
  }
}
[18:44:36.190] Task URL: https://cr-buildbucket.appspot.com/build/8838626564121508512
[18:44:36.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:2:0) after 2m5s
[18:46:41.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:2:0)
[18:46:41.410] Build status: SCHEDULED
[18:46:41.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:3:0) after 3m52s
[18:50:34.043] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:3:0)
[18:50:34.068] Build status: SCHEDULED
[18:50:34.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:4:0) after 9m32s
[19:00:06.197] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:4:0)
[19:00:06.248] Build status: SCHEDULED
[19:00:06.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:5:0) after 3m37s
[19:03:43.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:5:0)
[19:03:43.328] Build status: SCHEDULED
[19:03:43.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:6:0) after 1m32s
[19:05:15.365] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:6:0)
[19:05:15.417] Build status: SCHEDULED
[19:05:15.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:7:0) after 7m45s
[19:13:00.583] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:7:0)
[19:13:00.617] Build status: SCHEDULED
[19:13:00.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:8:0) after 2m47s
[19:15:48.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:8:0)
[19:15:48.119] Build status: SCHEDULED
[19:15:48.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:9:0) after 2m54s
[19:18:42.180] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:9:0)
[19:18:42.219] Build status: SCHEDULED
[19:18:42.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:10:0) after 6m9s
[19:24:51.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:10:0)
[19:24:51.393] Build status: SCHEDULED
[19:24:51.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:11:0) after 6m13s
[19:31:04.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:11:0)
[19:31:04.679] Build status: SCHEDULED
[19:31:04.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:12:0) after 1m47s
[19:32:51.696] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:12:0)
[19:32:51.739] Build status: SCHEDULED
[19:32:51.739] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:13:0) after 1m45s
[19:34:36.763] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:13:0)
[19:34:36.800] Build status: SCHEDULED
[19:34:36.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:14:0) after 3m11s
[19:37:47.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:14:0)
[19:37:47.854] Build status: SCHEDULED
[19:37:47.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:15:0) after 7m12s
[19:45:00.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:15:0)
[19:45:00.271] Build status: SCHEDULED
[19:45:00.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:16:0) after 4m1s
[19:49:01.631] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:16:0)
[19:49:01.728] Build status: SCHEDULED
[19:49:01.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:17:0) after 6m14s
[19:55:15.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:17:0)
[19:55:15.805] Build status: SCHEDULED
[19:55:15.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:18:0) after 2m6s
[19:57:21.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:18:0)
[19:57:21.849] Build status: SCHEDULED
[19:57:21.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:19:0) after 4m51s
[20:02:12.838] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:19:0)
[20:02:12.866] Build status: SCHEDULED
[20:02:12.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:20:0) after 4m31s
[20:06:43.905] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:20:0)
[20:06:43.938] Build status: SCHEDULED
[20:06:43.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:21:0) after 6m30s
[20:13:14.129] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:21:0)
[20:13:14.158] Build status: SCHEDULED
[20:13:14.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:22:0) after 2m13s
[20:15:27.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:22:0)
[20:15:27.457] Build status: SCHEDULED
[20:15:27.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:23:0) after 8m24s
[20:20:33.553] Received PubSub notification, asking Buildbucket for the build status
[20:20:33.578] Build status: STARTED
[20:23:51.576] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:23:0)
[20:23:51.627] Build status: STARTED
[20:23:51.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:25:0) after 4m9s
[20:28:01.060] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:25:0)
[20:28:01.091] Build status: STARTED
[20:28:01.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:26:0) after 7m35s
[20:35:36.109] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:26:0)
[20:35:36.136] Build status: STARTED
[20:35:36.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:27:0) after 3m9s
[20:38:45.253] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:27:0)
[20:38:45.283] Build status: STARTED
[20:38:45.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:28:0) after 8m52s
[20:47:37.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:28:0)
[20:47:37.428] Build status: STARTED
[20:47:37.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:29:0) after 2m28s
[20:50:05.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:29:0)
[20:50:05.492] Build status: STARTED
[20:50:05.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:30:0) after 6m30s
[20:56:36.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:30:0)
[20:56:36.142] Build status: STARTED
[20:56:36.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:31:0) after 8m36s
[21:05:12.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:31:0)
[21:05:12.187] Build status: STARTED
[21:05:12.187] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:32:0) after 5m47s
[21:10:59.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:32:0)
[21:10:59.242] Build status: STARTED
[21:10:59.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:33:0) after 1m50s
[21:12:49.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:33:0)
[21:12:49.301] Build status: STARTED
[21:12:49.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:34:0) after 8m42s
[21:21:31.323] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:34:0)
[21:21:31.357] Build status: STARTED
[21:21:31.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:35:0) after 9m24s
[21:30:55.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:35:0)
[21:30:55.479] Build status: STARTED
[21:30:55.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:36:0) after 6m7s
[21:37:02.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:36:0)
[21:37:02.553] Build status: STARTED
[21:37:02.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:37:0) after 4m46s
[21:41:48.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:37:0)
[21:41:48.698] Build status: STARTED
[21:41:48.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:38:0) after 3m8s
[21:44:56.902] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:38:0)
[21:44:56.932] Build status: STARTED
[21:44:56.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:39:0) after 4m33s
[21:49:30.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:39:0)
[21:49:30.064] Build status: STARTED
[21:49:30.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:40:0) after 8m33s
[21:58:03.092] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:40:0)
[21:58:03.125] Build status: STARTED
[21:58:03.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:41:0) after 5m42s
[22:03:45.683] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:41:0)
[22:03:45.709] Build status: STARTED
[22:03:45.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:42:0) after 5m33s
[22:09:18.788] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:42:0)
[22:09:18.817] Build status: STARTED
[22:09:18.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:43:0) after 8m14s
[22:17:32.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:43:0)
[22:17:32.929] Build status: STARTED
[22:17:32.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:44:0) after 6m15s
[22:23:47.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:44:0)
[22:23:48.029] Build status: STARTED
[22:23:48.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:45:0) after 8m45s
[22:32:33.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:45:0)
[22:32:33.221] Build status: STARTED
[22:32:33.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:46:0) after 7m10s
[22:39:43.343] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:46:0)
[22:39:43.372] Build status: STARTED
[22:39:43.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:47:0) after 5m17s
[22:45:00.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:47:0)
[22:45:00.420] Build status: STARTED
[22:45:00.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:48:0) after 9m26s
[22:54:26.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:48:0)
[22:54:26.518] Build status: STARTED
[22:54:26.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9004056626351619808:49:0) after 4m32s
[22:56:05.580] Received PubSub notification, asking Buildbucket for the build status
[22:56:05.614] Build:
{
  "id": "8838626564121508512",
  "builder": {
    "project": "nacl",
    "bucket": "toolchain",
    "builder": "linux-pnacl-x86_64-tests-x86_64"
  },
  "number": 5200,
  "createdBy": "project:nacl",
  "createTime": "2021-08-17T18:44:35.699553Z",
  "startTime": "2021-08-17T20:20:32.934829Z",
  "endTime": "2021-08-17T22:56:05.226366227Z",
  "updateTime": "2021-08-17T22:56:05.226863457Z",
  "status": "FAILURE",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "63b3cb448cf22e589a4d125ee1829c894cb582c2",
      "ref": "refs/heads/master"
    }
  }
}
[22:56:05.614] Invocation finished in 4h11m31.42567266s with status FAILED