[38.120648] Initializing watchdogs
[38.120733]   /dev/watchdog0
[38.151026] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[38.157253] [001/162] (960s left) i915_module_load (load)
[38.208533] Starting subtest: load
[39.376732] Subtest load: SUCCESS (1.168s)
[39.440600] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[39.444207] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[39.447367] [002/162] (959s left) core_auth (basic-auth)
[39.564018] Starting subtest: basic-auth
[39.578954] Subtest basic-auth: SUCCESS (0.015s)
[39.637397] [003/162] (959s left) core_debugfs (read-all-entries)
[39.709662] Starting subtest: read-all-entries
[39.712585] Subtest read-all-entries: SUCCESS (0.004s)
[39.771970] [004/162] (959s left) core_sysfs (read-all-entries)
[39.843770] Starting subtest: read-all-entries
[39.848803] Subtest read-all-entries: SUCCESS (0.006s)
[39.908389] [005/162] (959s left) fbdev (eof)
[39.980264] Subtest eof: SKIP (0.000s)
[40.036901] [006/162] (958s left) fbdev (info)
[40.108351] Subtest info: SKIP (0.000s)
[40.165096] [007/162] (958s left) fbdev (nullptr)
[40.235770] Subtest nullptr: SKIP (0.000s)
[40.292103] [008/162] (958s left) fbdev (read)
[40.362367] Subtest read: SKIP (0.000s)
[40.418547] [009/162] (958s left) fbdev (write)
[40.488539] Subtest write: SKIP (0.000s)
[40.544461] [010/162] (958s left) gem_basic (bad-close)
[40.615884] Starting subtest: bad-close
[40.617717] Subtest bad-close: SUCCESS (0.000s)
[40.674738] [011/162] (958s left) gem_basic (create-close)
[40.749228] Starting subtest: create-close
[40.750990] Subtest create-close: SUCCESS (0.000s)
[40.843726] [012/162] (958s left) gem_basic (create-fd-close)
[40.917548] Starting subtest: create-fd-close
[40.919527] Subtest create-fd-close: SUCCESS (0.000s)
[41.000411] [013/162] (958s left) gem_busy (busy@all-engines)
[41.091730] Starting subtest: busy
[41.092791] Starting dynamic subtest: all-engines
[41.167248] Dynamic subtest all-engines: SUCCESS (0.075s)
[41.168370] Subtest busy: SUCCESS (0.076s)
[41.586315] [014/162] (957s left) gem_close_race (basic-process)
[41.698026] Starting subtest: basic-process
[41.743546] Subtest basic-process: SUCCESS (0.046s)
[41.976435] [015/162] (957s left) gem_close_race (basic-threads)
[42.085600] Starting subtest: basic-threads
[43.298539] Subtest basic-threads: SUCCESS (1.213s)
[43.606869] [016/162] (956s left) gem_ctx_create (basic)
[43.692816] Starting subtest: basic
[43.693834] Subtest basic: SUCCESS (0.000s)
[43.856961] [017/162] (955s left) gem_ctx_create (basic-files)
[43.940908] Starting subtest: basic-files
[45.957643] Subtest basic-files: SUCCESS (2.017s)
[46.419470] [018/162] (953s left) gem_ctx_exec (basic)
[46.495585] Starting subtest: basic
[46.505153] Subtest basic: SUCCESS (0.010s)
[46.609865] [019/162] (953s left) gem_exec_basic (basic)
[46.689049] Starting subtest: basic
[46.690076] Starting dynamic subtest: rcs0-smem
[46.692398] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[46.702651] Starting dynamic subtest: bcs0-smem
[46.703506] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[46.711519] Starting dynamic subtest: vcs0-smem
[46.712608] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[46.720521] Starting dynamic subtest: vcs1-smem
[46.721684] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[46.729521] Starting dynamic subtest: vecs0-smem
[46.730685] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[46.738521] Starting dynamic subtest: rcs0-lmem0
[46.739712] Dynamic subtest rcs0-lmem0: SUCCESS (0.002s)
[46.747556] Starting dynamic subtest: bcs0-lmem0
[46.748777] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[46.756598] Starting dynamic subtest: vcs0-lmem0
[46.757808] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[46.765630] Starting dynamic subtest: vcs1-lmem0
[46.766816] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[46.774635] Starting dynamic subtest: vecs0-lmem0
[46.775822] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[46.777040] Subtest basic: SUCCESS (0.016s)
[46.888938] [020/162] (953s left) gem_exec_create (basic)
[46.977746] Starting subtest: basic
[46.978681] Starting dynamic subtest: smem
[49.075626] Dynamic subtest smem: SUCCESS (2.098s)
[49.084694] Starting dynamic subtest: lmem0
[51.175314] Dynamic subtest lmem0: SUCCESS (2.099s)
[51.176247] Subtest basic: SUCCESS (4.198s)
[51.357834] [021/162] (948s left) gem_exec_fence (basic-busy)
[51.563365] Starting subtest: basic-busy
[51.564274] Starting dynamic subtest: rcs0
[51.670466] Dynamic subtest rcs0: SUCCESS (0.106s)
[51.682401] Starting dynamic subtest: bcs0
[51.720398] Dynamic subtest bcs0: SUCCESS (0.049s)
[51.737978] Starting dynamic subtest: vcs0
[51.774048] Dynamic subtest vcs0: SUCCESS (0.052s)
[51.810403] Starting dynamic subtest: vcs1
[51.836472] Dynamic subtest vcs1: SUCCESS (0.062s)
[51.852950] Starting dynamic subtest: vecs0
[51.888101] Dynamic subtest vecs0: SUCCESS (0.051s)
[51.889903] Subtest basic-busy: SUCCESS (0.325s)
[52.582456] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[52.584930] [022/162] (947s left) gem_exec_fence (basic-wait)
[52.799486] Starting subtest: basic-wait
[52.800434] Starting dynamic subtest: rcs0
[52.877195] Dynamic subtest rcs0: SUCCESS (0.078s)
[52.889041] Starting dynamic subtest: bcs0
[52.931076] Dynamic subtest bcs0: SUCCESS (0.052s)
[52.966507] Starting dynamic subtest: vcs0
[52.992521] Dynamic subtest vcs0: SUCCESS (0.061s)
[53.009133] Starting dynamic subtest: vcs1
[53.048626] Dynamic subtest vcs1: SUCCESS (0.055s)
[53.085532] Starting dynamic subtest: vecs0
[53.111518] Dynamic subtest vecs0: SUCCESS (0.062s)
[53.112637] Subtest basic-wait: SUCCESS (0.312s)
[53.723998] [023/162] (946s left) gem_exec_fence (basic-await)
[53.935424] Starting subtest: basic-await
[53.936405] Starting dynamic subtest: rcs0
[54.050593] Dynamic subtest rcs0: SUCCESS (0.115s)
[54.059762] Starting dynamic subtest: bcs0
[54.137183] Dynamic subtest bcs0: SUCCESS (0.086s)
[54.147975] Starting dynamic subtest: vcs0
[54.229756] Dynamic subtest vcs0: SUCCESS (0.092s)
[54.241470] Starting dynamic subtest: vcs1
[54.324595] Dynamic subtest vcs1: SUCCESS (0.094s)
[54.337593] Starting dynamic subtest: vecs0
[54.422839] Dynamic subtest vecs0: SUCCESS (0.098s)
[54.424028] Subtest basic-await: SUCCESS (0.488s)
[55.007667] [024/162] (945s left) gem_exec_fence (nb-await)
[55.232437] Starting subtest: nb-await
[55.233581] Starting dynamic subtest: rcs0
[55.331641] Dynamic subtest rcs0: SUCCESS (0.100s)
[55.342205] Starting dynamic subtest: bcs0
[55.396861] Dynamic subtest bcs0: SUCCESS (0.065s)
[55.420688] Starting dynamic subtest: vcs0
[55.484491] Dynamic subtest vcs0: SUCCESS (0.086s)
[55.518210] Starting dynamic subtest: vcs1
[55.576383] Dynamic subtest vcs1: SUCCESS (0.090s)
[55.607839] Starting dynamic subtest: vecs0
[55.667931] Dynamic subtest vecs0: SUCCESS (0.090s)
[55.670439] Subtest nb-await: SUCCESS (0.437s)
[56.231126] [025/162] (944s left) gem_exec_gttfill (basic)
[56.330287] Starting subtest: basic
[63.945232] Subtest basic: SUCCESS (7.612s)
[64.162241] [026/162] (936s left) gem_exec_parallel (engines)
[64.309286] Starting subtest: engines
[64.310182] Starting dynamic subtest: basic
[67.253090] Dynamic subtest basic: SUCCESS (2.944s)
[67.262325] Starting dynamic subtest: contexts
[71.955692] Dynamic subtest contexts: SUCCESS (4.699s)
[71.964549] Starting dynamic subtest: fds
[75.459733] Dynamic subtest fds: SUCCESS (3.504s)
[75.469997] Starting dynamic subtest: userptr
[167.400541] Inactivity timeout exceeded. Killing the current test with SIGQUIT.
[167.402136] Warning: kernel log ringbuffer underflow, some records lost.
[286.106103] Timeout. Killing the current test with SIGKILL.
[286.209488] Closing watchdogs
[286.214846] Initializing watchdogs
[286.214906]   /dev/watchdog0
[286.247682] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[286.266983] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[286.270587] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[286.271291] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[286.274430] [027/162] (714s left) gem_exec_store (basic)
[286.415432] Starting subtest: basic
[286.553813] Subtest basic: SUCCESS (0.138s)
[286.802829] [028/162] (713s left) gem_flink_basic (bad-flink)
[286.886476] Starting subtest: bad-flink
[286.887468] Subtest bad-flink: SUCCESS (0.000s)
[286.953238] [029/162] (713s left) gem_flink_basic (bad-open)
[287.037974] Starting subtest: bad-open
[287.039178] Subtest bad-open: SUCCESS (0.000s)
[287.103822] [030/162] (713s left) gem_flink_basic (basic)
[287.189570] Starting subtest: basic
[287.190428] Subtest basic: SUCCESS (0.000s)
[287.272326] [031/162] (713s left) gem_flink_basic (double-flink)
[287.357091] Starting subtest: double-flink
[287.358282] Subtest double-flink: SUCCESS (0.000s)
[287.443521] [032/162] (713s left) gem_flink_basic (flink-lifetime)
[287.527786] Starting subtest: flink-lifetime
[287.569704] Subtest flink-lifetime: SUCCESS (0.043s)
[287.661554] [033/162] (713s left) gem_huc_copy (huc-copy)
[287.777680] Starting subtest: huc-copy
[287.785516] Subtest huc-copy: SUCCESS (0.008s)
[287.897631] [034/162] (713s left) gem_linear_blits (basic)
[288.158098] Starting subtest: basic
[288.189459] Subtest basic: SUCCESS (0.031s)
[288.325884] [035/162] (712s left) gem_mmap (basic)
[288.476381] Subtest basic: SKIP (0.000s)
[288.542686] [036/162] (712s left) gem_mmap_gtt (basic)
[288.633476] Subtest basic: SKIP (0.000s)
[288.710635] [037/162] (712s left) gem_render_linear_blits (basic)
[288.804574] Starting subtest: basic
[288.891124] Subtest basic: SUCCESS (0.086s)
[288.992487] [038/162] (712s left) gem_render_tiled_blits (basic)
[289.084275] Subtest basic: SKIP (0.000s)
[289.150647] [039/162] (712s left) gem_ringfill (basic-all)
[289.606540] Starting subtest: basic-all
[290.882232] Subtest basic-all: SUCCESS (1.275s)
[290.985640] [040/162] (710s left) gem_softpin (allocator-basic)
[291.077893] Starting subtest: allocator-basic
[291.362569] Subtest allocator-basic: SUCCESS (0.282s)
[291.471700] [041/162] (710s left) gem_softpin (allocator-basic-reserve)
[291.563907] Starting subtest: allocator-basic-reserve
[291.847297] Subtest allocator-basic-reserve: SUCCESS (0.280s)
[291.958160] [042/162] (709s left) gem_softpin (safe-alignment)
[292.051892] Starting subtest: safe-alignment
[292.106720] Subtest safe-alignment: SUCCESS (0.055s)
[292.205364] [043/162] (709s left) gem_sync (basic-all)
[292.306375] Starting subtest: basic-all
[294.386415] Subtest basic-all: SUCCESS (2.080s)
[294.566641] [044/162] (707s left) gem_sync (basic-each)
[294.665819] Starting subtest: basic-each
[297.205321] Subtest basic-each: SUCCESS (2.540s)
[297.490698] [045/162] (704s left) gem_tiled_blits (basic)
[297.583255] Subtest basic: SKIP (0.000s)
[297.650513] [046/162] (704s left) gem_tiled_fence_blits (basic)
[297.743355] Subtest basic: SKIP (0.000s)
[297.809892] [047/162] (704s left) gem_tiled_pread_basic (basic)
[297.895138] Subtest basic: SKIP (0.000s)
[297.976140] [048/162] (704s left) gem_wait (busy@all-engines)
[298.081362] Starting subtest: busy
[298.082263] Starting dynamic subtest: all-engines
[298.654538] Dynamic subtest all-engines: SUCCESS (0.574s)
[298.655456] Subtest busy: SUCCESS (0.575s)
[298.884342] [049/162] (703s left) gem_wait (wait@all-engines)
[298.988845] Starting subtest: wait
[298.989792] Starting dynamic subtest: all-engines
[300.099602] Dynamic subtest all-engines: SUCCESS (1.110s)
[300.104176] Subtest wait: SUCCESS (1.112s)
[300.412934] [050/162] (701s left) i915_getparams_basic (basic-eu-total)
[300.499721] Starting subtest: basic-eu-total
[300.501454] Subtest basic-eu-total: SUCCESS (0.000s)
[300.565671] [051/162] (701s left) i915_getparams_basic (basic-subslice-total)
[300.649115] Starting subtest: basic-subslice-total
[300.650962] Subtest basic-subslice-total: SUCCESS (0.000s)
[300.716778] [052/162] (701s left) i915_hangman (error-state-basic)
[300.820674] Starting subtest: error-state-basic
[300.968772] Subtest error-state-basic: SUCCESS (0.148s)
[301.043258] [053/162] (701s left) i915_pciid
[301.195352] [054/162] (701s left) intel_hwmon (hwmon-read)
[301.281929] Starting subtest: hwmon-read
[301.284037] Subtest hwmon-read: SUCCESS (0.003s)
[301.351561] [055/162] (701s left) intel_hwmon (hwmon-write)
[301.438276] Starting subtest: hwmon-write
[301.546244] Subtest hwmon-write: SUCCESS (0.106s)
[301.609664] [056/162] (700s left) kms_addfb_basic (addfb25-4-tiled)
[301.777391] Starting subtest: addfb25-4-tiled
[301.778246] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[301.860589] [057/162] (700s left) kms_addfb_basic (addfb25-bad-modifier)
[302.025259] Starting subtest: addfb25-bad-modifier
[302.026128] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[302.111331] [058/162] (700s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[302.274852] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[302.352595] [059/162] (700s left) kms_addfb_basic (addfb25-modifier-no-flag)
[302.517942] Starting subtest: addfb25-modifier-no-flag
[302.518877] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[302.607327] [060/162] (700s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[302.771586] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[302.848603] [061/162] (700s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[303.015290] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[303.103701] [062/162] (699s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[303.268389] Starting subtest: addfb25-yf-tiled-legacy
[303.269203] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[303.362192] [063/162] (699s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[303.526699] Starting subtest: addfb25-y-tiled-legacy
[303.527699] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[303.613736] [064/162] (699s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[303.779145] Starting subtest: addfb25-y-tiled-small-legacy
[303.780200] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[303.868228] [065/162] (699s left) kms_addfb_basic (bad-pitch-0)
[303.955218] Starting subtest: bad-pitch-0
[303.956291] Subtest bad-pitch-0: SUCCESS (0.000s)
[304.117866] [066/162] (699s left) kms_addfb_basic (bad-pitch-1024)
[304.204285] Starting subtest: bad-pitch-1024
[304.205286] Subtest bad-pitch-1024: SUCCESS (0.000s)
[304.370715] [067/162] (698s left) kms_addfb_basic (bad-pitch-128)
[304.459182] Starting subtest: bad-pitch-128
[304.460306] Subtest bad-pitch-128: SUCCESS (0.000s)
[304.622683] [068/162] (698s left) kms_addfb_basic (bad-pitch-256)
[304.709396] Starting subtest: bad-pitch-256
[304.710398] Subtest bad-pitch-256: SUCCESS (0.000s)
[304.872157] [069/162] (698s left) kms_addfb_basic (bad-pitch-32)
[304.959170] Starting subtest: bad-pitch-32
[304.960155] Subtest bad-pitch-32: SUCCESS (0.000s)
[305.124987] [070/162] (698s left) kms_addfb_basic (bad-pitch-63)
[305.211163] Starting subtest: bad-pitch-63
[305.212196] Subtest bad-pitch-63: SUCCESS (0.000s)
[305.376902] [071/162] (698s left) kms_addfb_basic (bad-pitch-65536)
[305.463209] Starting subtest: bad-pitch-65536
[305.464222] Subtest bad-pitch-65536: SUCCESS (0.000s)
[305.626398] [072/162] (698s left) kms_addfb_basic (bad-pitch-999)
[305.715266] Starting subtest: bad-pitch-999
[305.716296] Subtest bad-pitch-999: SUCCESS (0.000s)
[305.883803] [073/162] (697s left) kms_addfb_basic (basic)
[305.969383] Starting subtest: basic
[305.970410] Subtest basic: SUCCESS (0.000s)
[306.137970] [074/162] (697s left) kms_addfb_basic (basic-x-tiled-legacy)
[306.226587] Starting subtest: basic-x-tiled-legacy
[306.228731] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[306.379695] [075/162] (697s left) kms_addfb_basic (basic-y-tiled-legacy)
[306.466964] Starting subtest: basic-y-tiled-legacy
[306.468956] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[306.631082] [076/162] (697s left) kms_addfb_basic (bo-too-small)
[306.797518] Starting subtest: bo-too-small
[306.798499] Subtest bo-too-small: SUCCESS (0.000s)
[306.887627] [077/162] (697s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[307.053571] Starting subtest: bo-too-small-due-to-tiling
[307.055772] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[307.139668] [078/162] (696s left) kms_addfb_basic (clobberred-modifier)
[307.228408] Starting subtest: clobberred-modifier
[307.230476] Subtest clobberred-modifier: SKIP (0.000s)
[307.393617] [079/162] (696s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[307.481354] Starting subtest: framebuffer-vs-set-tiling
[307.483423] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[307.649391] [080/162] (696s left) kms_addfb_basic (invalid-get-prop)
[307.736811] Starting subtest: invalid-get-prop
[307.737824] Subtest invalid-get-prop: SUCCESS (0.000s)
[307.899734] [081/162] (696s left) kms_addfb_basic (invalid-get-prop-any)
[307.988104] Starting subtest: invalid-get-prop-any
[307.989108] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[308.152792] [082/162] (696s left) kms_addfb_basic (invalid-set-prop)
[308.238292] Starting subtest: invalid-set-prop
[308.239281] Subtest invalid-set-prop: SUCCESS (0.000s)
[308.403229] [083/162] (696s left) kms_addfb_basic (invalid-set-prop-any)
[308.490239] Starting subtest: invalid-set-prop-any
[308.491302] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[308.661332] [084/162] (695s left) kms_addfb_basic (no-handle)
[308.747319] Starting subtest: no-handle
[308.748429] Subtest no-handle: SUCCESS (0.000s)
[308.917683] [085/162] (695s left) kms_addfb_basic (size-max)
[309.082619] Starting subtest: size-max
[309.083620] Subtest size-max: SUCCESS (0.000s)
[309.167960] [086/162] (695s left) kms_addfb_basic (small-bo)
[309.333462] Starting subtest: small-bo
[309.334413] Subtest small-bo: SUCCESS (0.000s)
[309.453866] [087/162] (695s left) kms_addfb_basic (tile-pitch-mismatch)
[309.540252] Starting subtest: tile-pitch-mismatch
[309.542183] Subtest tile-pitch-mismatch: SKIP (0.000s)
[309.705612] [088/162] (695s left) kms_addfb_basic (too-high)
[309.871539] Starting subtest: too-high
[309.872619] Subtest too-high: SUCCESS (0.001s)
[309.962508] [089/162] (694s left) kms_addfb_basic (too-wide)
[310.127522] Starting subtest: too-wide
[310.128523] Subtest too-wide: SUCCESS (0.000s)
[310.217300] [090/162] (694s left) kms_addfb_basic (unused-handle)
[310.305224] Starting subtest: unused-handle
[310.306293] Subtest unused-handle: SUCCESS (0.000s)
[310.475921] [091/162] (694s left) kms_addfb_basic (unused-modifier)
[310.563498] Starting subtest: unused-modifier
[310.564522] Subtest unused-modifier: SUCCESS (0.000s)
[310.724901] [092/162] (694s left) kms_addfb_basic (unused-offsets)
[310.813230] Starting subtest: unused-offsets
[310.814437] Subtest unused-offsets: SUCCESS (0.000s)
[310.978736] [093/162] (694s left) kms_addfb_basic (unused-pitches)
[311.065541] Starting subtest: unused-pitches
[311.066729] Subtest unused-pitches: SUCCESS (0.000s)
[311.231707] [094/162] (694s left) kms_busy (basic)
[311.401482] Subtest basic: SKIP (0.000s)
[311.469622] [095/162] (693s left) kms_prop_blob (basic)
[311.557177] Starting subtest: basic
[311.558181] Subtest basic: SUCCESS (0.000s)
[311.624679] [096/162] (693s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[311.795629] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[311.860664] [097/162] (693s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[312.030364] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[312.095823] [098/162] (693s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[312.267540] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[312.333687] [099/162] (693s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[312.507195] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[312.572544] [100/162] (693s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[312.743216] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[312.807362] [101/162] (692s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[312.977132] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[313.041647] [102/162] (692s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[313.210883] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[313.276520] [103/162] (692s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[313.445326] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[313.510446] [104/162] (692s left) kms_dsc (dsc-basic)
[313.675319] Subtest dsc-basic: SKIP (0.000s)
[313.742554] [105/162] (692s left) kms_flip (basic-flip-vs-dpms)
[313.908880] Starting subtest: basic-flip-vs-dpms
[313.912441] Subtest basic-flip-vs-dpms: SKIP (0.004s)
[313.990079] [106/162] (692s left) kms_flip (basic-flip-vs-modeset)
[314.154858] Starting subtest: basic-flip-vs-modeset
[314.158384] Subtest basic-flip-vs-modeset: SKIP (0.004s)
[314.234189] [107/162] (691s left) kms_flip (basic-flip-vs-wf_vblank)
[314.398819] Starting subtest: basic-flip-vs-wf_vblank
[314.402451] Subtest basic-flip-vs-wf_vblank: SKIP (0.004s)
[314.478521] [108/162] (691s left) kms_flip (basic-plain-flip)
[314.642794] Starting subtest: basic-plain-flip
[314.648264] Subtest basic-plain-flip: SKIP (0.004s)
[314.725110] [109/162] (691s left) kms_force_connector_basic (force-connector-state)
[314.854552] Starting subtest: force-connector-state
[315.014431] Subtest force-connector-state: SUCCESS (0.160s)
[315.300103] [110/162] (691s left) kms_force_connector_basic (force-edid)
[315.433660] Starting subtest: force-edid
[315.539036] Subtest force-edid: SUCCESS (0.108s)
[315.743528] [111/162] (690s left) kms_force_connector_basic (force-load-detect)
[315.871972] Starting subtest: force-load-detect
[315.874126] Subtest force-load-detect: SKIP (0.000s)
[316.041911] [112/162] (690s left) kms_force_connector_basic (prune-stale-modes)
[316.179682] Starting subtest: prune-stale-modes
[316.285646] Subtest prune-stale-modes: SUCCESS (0.111s)
[316.482589] [113/162] (690s left) kms_frontbuffer_tracking (basic)
[316.661568] Subtest basic: SKIP (0.000s)
[316.746858] [114/162] (689s left) kms_hdmi_inject (inject-audio)
[316.838277] Starting subtest: inject-audio
[316.964168] Subtest inject-audio: SUCCESS (0.126s)
[317.123956] [115/162] (689s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[317.301826] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[317.375794] [116/162] (689s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[317.551331] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[317.625947] [117/162] (689s left) kms_pipe_crc_basic (hang-read-crc)
[317.803500] Subtest hang-read-crc: SKIP (0.000s)
[317.879674] [118/162] (689s left) kms_pipe_crc_basic (nonblocking-crc)
[318.055495] Subtest nonblocking-crc: SKIP (0.000s)
[318.128958] [119/162] (688s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[318.306948] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[318.381346] [120/162] (688s left) kms_pipe_crc_basic (read-crc)
[318.555399] Subtest read-crc: SKIP (0.000s)
[318.629178] [121/162] (688s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[318.807190] Subtest read-crc-frame-sequence: SKIP (0.000s)
[318.912571] [122/162] (688s left) kms_pm_backlight (basic-brightness)
[319.088934] Subtest basic-brightness: SKIP (0.000s)
[319.164849] [123/162] (688s left) kms_pm_rpm (basic-pci-d3-state)
[320.634206] Starting subtest: basic-pci-d3-state
[320.963834] Subtest basic-pci-d3-state: SUCCESS (0.332s)
[321.063855] [124/162] (686s left) kms_pm_rpm (basic-rte)
[321.127232] Starting subtest: basic-rte
[322.750548] Subtest basic-rte: SUCCESS (1.623s)
[323.170928] [125/162] (684s left) kms_psr (psr-primary-page-flip)
[323.346570] Subtest psr-primary-page-flip: SKIP (0.000s)
[323.419284] [126/162] (684s left) kms_psr (psr-cursor-plane-move)
[323.595417] Subtest psr-cursor-plane-move: SKIP (0.000s)
[323.669564] [127/162] (683s left) kms_psr (psr-sprite-plane-onoff)
[323.843787] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[323.917588] [128/162] (683s left) kms_psr (psr-primary-mmap-gtt)
[324.094052] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[324.167273] [129/162] (683s left) kms_setmode (basic-clone-single-crtc)
[324.255849] Starting subtest: basic-clone-single-crtc
[324.258593] Subtest basic-clone-single-crtc: SKIP (0.000s)
[324.333876] [130/162] (683s left) i915_pm_rps (basic-api)
[324.435092] Starting subtest: basic-api
[324.437467] Subtest basic-api: SKIP (0.001s)
[324.513345] [131/162] (683s left) prime_self_import (basic-llseek-bad)
[324.579235] Starting subtest: basic-llseek-bad
[324.602711] Subtest basic-llseek-bad: SUCCESS (0.024s)
[324.699766] [132/162] (683s left) prime_self_import (basic-llseek-size)
[324.763486] Starting subtest: basic-llseek-size
[324.787427] Subtest basic-llseek-size: SUCCESS (0.026s)
[324.887892] [133/162] (683s left) prime_self_import (basic-with_fd_dup)
[324.951331] Starting subtest: basic-with_fd_dup
[324.996831] Subtest basic-with_fd_dup: SUCCESS (0.045s)
[325.089582] [134/162] (682s left) prime_self_import (basic-with_one_bo)
[325.153151] Starting subtest: basic-with_one_bo
[325.198794] Subtest basic-with_one_bo: SUCCESS (0.046s)
[325.278209] [135/162] (682s left) prime_self_import (basic-with_one_bo_two_files)
[325.342840] Starting subtest: basic-with_one_bo_two_files
[325.390223] Subtest basic-with_one_bo_two_files: SUCCESS (0.045s)
[325.488176] [136/162] (682s left) prime_self_import (basic-with_two_bos)
[325.551279] Starting subtest: basic-with_two_bos
[325.595513] Subtest basic-with_two_bos: SUCCESS (0.045s)
[325.717953] [137/162] (682s left) prime_vgem (basic-fence-flip)
[325.820290] Starting subtest: basic-fence-flip
[325.907439] Subtest basic-fence-flip: SKIP (0.088s)
[325.987845] [138/162] (682s left) prime_vgem (basic-fence-mmap)
[326.086864] Starting subtest: basic-fence-mmap
[326.089114] Subtest basic-fence-mmap: SKIP (0.000s)
[326.188834] [139/162] (682s left) prime_vgem (basic-fence-read)
[326.289565] Starting subtest: basic-fence-read
[326.302659] Subtest basic-fence-read: SKIP (0.012s)
[326.432695] [140/162] (682s left) prime_vgem (basic-gtt)
[326.534027] Starting subtest: basic-gtt
[326.536490] Subtest basic-gtt: SKIP (0.000s)
[326.635141] [141/162] (681s left) prime_vgem (basic-read)
[326.746780] Starting subtest: basic-read
[326.758235] Subtest basic-read: SKIP (0.010s)
[326.864440] [142/162] (681s left) prime_vgem (basic-write)
[326.963673] Starting subtest: basic-write
[326.972831] Subtest basic-write: SKIP (0.008s)
[327.073528] [143/162] (681s left) vgem_basic (setversion)
[327.142924] Starting subtest: setversion
[327.144664] Subtest setversion: SUCCESS (0.000s)
[327.216049] [144/162] (681s left) vgem_basic (create)
[327.284518] Starting subtest: create
[327.285339] Subtest create: SUCCESS (0.000s)
[327.356215] [145/162] (681s left) vgem_basic (debugfs)
[327.424656] Starting subtest: debugfs
[327.425490] Subtest debugfs: SUCCESS (0.001s)
[327.497011] [146/162] (681s left) vgem_basic (dmabuf-export)
[327.564995] Starting subtest: dmabuf-export
[327.590027] Subtest dmabuf-export: SUCCESS (0.025s)
[327.686646] [147/162] (681s left) vgem_basic (dmabuf-fence)
[327.755051] Starting subtest: dmabuf-fence
[327.755951] Subtest dmabuf-fence: SUCCESS (0.001s)
[327.828543] [148/162] (681s left) vgem_basic (dmabuf-fence-before)
[327.898132] Starting subtest: dmabuf-fence-before
[327.899164] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[327.971723] [149/162] (681s left) vgem_basic (dmabuf-mmap)
[328.040577] Starting subtest: dmabuf-mmap
[328.052052] Subtest dmabuf-mmap: SUCCESS (0.012s)
[328.125690] [150/162] (681s left) vgem_basic (mmap)
[328.196116] Starting subtest: mmap
[328.203581] Subtest mmap: SUCCESS (0.009s)
[328.276589] [151/162] (681s left) vgem_basic (second-client)
[328.346507] Starting subtest: second-client
[328.351098] Subtest second-client: SUCCESS (0.005s)
[328.423682] [152/162] (680s left) vgem_basic (sysfs)
[328.492511] Starting subtest: sysfs
[328.493539] Subtest sysfs: SUCCESS (0.000s)
[328.566306] [153/162] (680s left) core_hotunplug (unbind-rebind)
[328.708776] Starting subtest: unbind-rebind
[331.932929] Subtest unbind-rebind: SUCCESS (3.226s)
[332.002428] [154/162] (677s left) vgem_basic (unload)
[332.065512] Starting subtest: unload
[360.930749] Subtest unload: SUCCESS (28.863s)
[361.028653] [155/162] (648s left) i915_module_load (reload)
[361.110617] Starting subtest: reload
[363.032428] Subtest reload: SUCCESS (1.922s)
[363.100053] [156/162] (646s left) gem_lmem_swapping (basic)
[367.737907] Starting subtest: basic
[367.739312] Starting dynamic subtest: lmem0
[414.598171] Dynamic subtest lmem0: SUCCESS (46.859s)
[414.599163] Subtest basic: SUCCESS (46.860s)
[415.962986] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[415.964272] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[415.966771] [157/162] (593s left) gem_lmem_swapping (parallel-random-engines)
[417.063224] Starting subtest: parallel-random-engines
[417.063996] Starting dynamic subtest: lmem0
[446.659489] Dynamic subtest lmem0: SUCCESS (29.594s)
[446.660544] Subtest parallel-random-engines: SUCCESS (29.595s)
[447.520384] [158/162] (562s left) gem_lmem_swapping (random-engines)
[448.599414] Starting subtest: random-engines
[448.600235] Starting dynamic subtest: lmem0
[450.165874] Dynamic subtest lmem0: SUCCESS (1.563s)
[450.167045] Subtest random-engines: SUCCESS (1.564s)
[569.109458] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[689.951368] Timeout. Killing the current test with SIGKILL.
[709.972548] Child refuses to die, tainted 0x44. Aborting.
[709.976227] Closing watchdogs
[710.006790] [FACT gem_lmem_swapping (random-engines)] new: kernel.kmod_is_loaded.i915: true
[710.008312] Closing watchdogs
results: parsing output: 0/ for test: i915_module_load
results: parsing output: 1/ for test: core_auth
results: parsing output: 2/ for test: core_debugfs
results: parsing output: 3/ for test: core_sysfs
results: parsing output: 4/ for test: fbdev
results: parsing output: 5/ for test: fbdev
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: fbdev
results: parsing output: 9/ for test: gem_basic
results: parsing output: 10/ for test: gem_basic
results: parsing output: 11/ for test: gem_basic
results: parsing output: 12/ for test: gem_busy
results: parsing output: 13/ for test: gem_close_race
results: parsing output: 14/ for test: gem_close_race
results: parsing output: 15/ for test: gem_ctx_create
results: parsing output: 16/ for test: gem_ctx_create
results: parsing output: 17/ for test: gem_ctx_exec
results: parsing output: 18/ for test: gem_exec_basic
results: parsing output: 19/ for test: gem_exec_create
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: gem_exec_gttfill
results: parsing output: 25/ for test: gem_exec_parallel
results: parsing output: 26/ for test: gem_exec_store
results: parsing output: 27/ for test: gem_flink_basic
results: parsing output: 28/ for test: gem_flink_basic
results: parsing output: 29/ for test: gem_flink_basic
results: parsing output: 30/ for test: gem_flink_basic
results: parsing output: 31/ for test: gem_flink_basic
results: parsing output: 32/ for test: gem_huc_copy
results: parsing output: 33/ for test: gem_linear_blits
results: parsing output: 34/ for test: gem_mmap
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_render_linear_blits
results: parsing output: 37/ for test: gem_render_tiled_blits
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_sync
results: parsing output: 43/ for test: gem_sync
results: parsing output: 44/ for test: gem_tiled_blits
results: parsing output: 45/ for test: gem_tiled_fence_blits
results: parsing output: 46/ for test: gem_tiled_pread_basic
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: i915_getparams_basic
results: parsing output: 50/ for test: i915_getparams_basic
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: i915_pciid
results: parsing output: 53/ for test: intel_hwmon
results: parsing output: 54/ for test: intel_hwmon
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: kms_prop_blob
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_dsc
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_force_connector_basic
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_force_connector_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_hdmi_inject
results: parsing output: 114/ for test: kms_pipe_crc_basic
results: parsing output: 115/ for test: kms_pipe_crc_basic
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: kms_pipe_crc_basic
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: i915_pm_rps
results: parsing output: 130/ for test: prime_self_import
results: parsing output: 131/ for test: prime_self_import
results: parsing output: 132/ for test: prime_self_import
results: parsing output: 133/ for test: prime_self_import
results: parsing output: 134/ for test: prime_self_import
results: parsing output: 135/ for test: prime_self_import
results: parsing output: 136/ for test: prime_vgem
results: parsing output: 137/ for test: prime_vgem
results: parsing output: 138/ for test: prime_vgem
results: parsing output: 139/ for test: prime_vgem
results: parsing output: 140/ for test: prime_vgem
results: parsing output: 141/ for test: prime_vgem
results: parsing output: 142/ for test: vgem_basic
results: parsing output: 143/ for test: vgem_basic
results: parsing output: 144/ for test: vgem_basic
results: parsing output: 145/ for test: vgem_basic
results: parsing output: 146/ for test: vgem_basic
results: parsing output: 147/ for test: vgem_basic
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: vgem_basic
results: parsing output: 150/ for test: vgem_basic
results: parsing output: 151/ for test: vgem_basic
results: parsing output: 152/ for test: core_hotunplug
results: parsing output: 153/ for test: vgem_basic
results: parsing output: 154/ for test: i915_module_load
results: parsing output: 155/ for test: gem_lmem_swapping
results: parsing output: 156/ for test: gem_lmem_swapping
results: parsing output: 157/ for test: gem_lmem_swapping
results: parsing output: 158/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 159/ for test: i915_pm_rpm
results: no output, setting notrun
results: parsing output: 160/ for test: i915_selftest
results: no output, setting notrun
results: parsing output: 161/ for test: dmabuf
results: no output, setting notrun
Done.