[43.071605] Initializing watchdogs [43.071685] /dev/watchdog0 [43.077208] [001/165] (960s left) i915_module_load (load) [43.133386] Starting subtest: load [44.522736] Subtest load: SUCCESS (1.389s) [44.537473] [002/165] (959s left) core_auth (basic-auth) [44.651414] Starting subtest: basic-auth [44.652469] Subtest basic-auth: SUCCESS (0.001s) [44.741897] [003/165] (958s left) debugfs_test (read_all_entries) [44.833686] Starting subtest: read_all_entries [45.376712] Subtest read_all_entries: SUCCESS (0.542s) [45.496177] [004/165] (958s left) debugfs_test (basic-hwmon) [45.566545] Starting subtest: basic-hwmon [45.572103] Subtest basic-hwmon: SUCCESS (0.004s) [45.696229] [005/165] (957s left) fbdev (eof) [45.773302] Starting subtest: eof [45.774301] Subtest eof: SUCCESS (0.000s) [45.845388] [006/165] (957s left) fbdev (info) [45.909333] Starting subtest: info [45.910539] Subtest info: SUCCESS (0.000s) [45.995732] [007/165] (957s left) fbdev (nullptr) [46.056387] Starting subtest: nullptr [46.057539] Subtest nullptr: SUCCESS (0.000s) [46.128439] [008/165] (957s left) fbdev (read) [46.189555] Starting subtest: read [58.536809] Subtest read: SUCCESS (12.347s) [58.601689] [009/165] (945s left) fbdev (write) [58.673219] Starting subtest: write [64.807918] Subtest write: SUCCESS (6.134s) [64.863074] [010/165] (938s left) gem_basic (bad-close) [64.925519] Starting subtest: bad-close [64.927499] Subtest bad-close: SUCCESS (0.000s) [65.018524] [011/165] (938s left) gem_basic (create-close) [65.091020] Starting subtest: create-close [65.092692] Subtest create-close: SUCCESS (0.000s) [65.216872] [012/165] (938s left) gem_basic (create-fd-close) [65.293450] Starting subtest: create-fd-close [65.295510] Subtest create-fd-close: SUCCESS (0.000s) [65.367636] [013/165] (938s left) gem_busy (busy@all-engines) [65.448536] Starting subtest: busy [65.449668] Starting dynamic subtest: all-engines [65.580475] Dynamic subtest all-engines: SUCCESS (0.132s) [65.581389] Subtest busy: SUCCESS (0.132s) [66.064332] [014/165] (937s left) gem_close_race (basic-process) [66.187159] Starting subtest: basic-process [66.225444] Subtest basic-process: SUCCESS (0.038s) [66.462292] [015/165] (937s left) gem_close_race (basic-threads) [66.561930] Starting subtest: basic-threads [67.799324] Subtest basic-threads: SUCCESS (1.238s) [68.112792] [016/165] (935s left) gem_ctx_create (basic) [68.200725] Starting subtest: basic [68.201774] Subtest basic: SUCCESS (0.000s) [68.445044] [017/165] (935s left) gem_ctx_create (basic-files) [68.519309] Starting subtest: basic-files [70.536153] Subtest basic-files: SUCCESS (2.017s) [71.113740] [018/165] (932s left) gem_ctx_exec (basic) [71.179445] Starting subtest: basic [71.183904] Subtest basic: SUCCESS (0.004s) [71.318354] [019/165] (932s left) gem_exec_basic (basic) [71.407353] Starting subtest: basic [71.408363] Starting dynamic subtest: rcs0-smem [71.410483] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [71.421635] Starting dynamic subtest: bcs0-smem [71.422555] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [71.431942] Starting dynamic subtest: vcs0-smem [71.432815] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [71.442306] Starting dynamic subtest: vcs1-smem [71.443407] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [71.452416] Starting dynamic subtest: vecs0-smem [71.453216] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [71.462490] Starting dynamic subtest: vecs1-smem [71.463574] Dynamic subtest vecs1-smem: SUCCESS (0.001s) [71.472962] Starting dynamic subtest: ccs0-smem [71.474141] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [71.483485] Starting dynamic subtest: ccs1-smem [71.484586] Dynamic subtest ccs1-smem: SUCCESS (0.001s) [71.493767] Starting dynamic subtest: ccs2-smem [71.494807] Dynamic subtest ccs2-smem: SUCCESS (0.001s) [71.503973] Starting dynamic subtest: ccs3-smem [71.504818] Dynamic subtest ccs3-smem: SUCCESS (0.001s) [71.514137] Starting dynamic subtest: rcs0-lmem0 [71.515240] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s) [71.524479] Starting dynamic subtest: bcs0-lmem0 [71.525417] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [71.535277] Starting dynamic subtest: vcs0-lmem0 [71.536353] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [71.545912] Starting dynamic subtest: vcs1-lmem0 [71.546754] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [71.556222] Starting dynamic subtest: vecs0-lmem0 [71.557109] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [71.566497] Starting dynamic subtest: vecs1-lmem0 [71.567509] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [71.580129] Starting dynamic subtest: ccs0-lmem0 [71.580935] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [71.590131] Starting dynamic subtest: ccs1-lmem0 [71.590989] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s) [71.600130] Starting dynamic subtest: ccs2-lmem0 [71.601141] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s) [71.610046] Starting dynamic subtest: ccs3-lmem0 [71.610830] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s) [71.611584] Subtest basic: SUCCESS (0.014s) [71.625121] [020/165] (932s left) gem_exec_create (basic) [71.700667] Starting subtest: basic [71.701574] Starting dynamic subtest: smem [73.816773] Dynamic subtest smem: SUCCESS (2.116s) [73.828663] Starting dynamic subtest: lmem0 [75.932419] Dynamic subtest lmem0: SUCCESS (2.116s) [75.933338] Subtest basic: SUCCESS (4.232s) [76.133701] [021/165] (927s left) gem_exec_fence (basic-busy) [76.373947] Starting subtest: basic-busy [76.375665] Starting dynamic subtest: rcs0 [76.493538] Dynamic subtest rcs0: SUCCESS (0.119s) [76.528998] Starting dynamic subtest: bcs0 [76.549804] Dynamic subtest bcs0: SUCCESS (0.057s) [76.567247] Starting dynamic subtest: vcs0 [76.603297] Dynamic subtest vcs0: SUCCESS (0.053s) [76.632087] Starting dynamic subtest: vcs1 [76.659851] Dynamic subtest vcs1: SUCCESS (0.057s) [76.678059] Starting dynamic subtest: vecs0 [76.713546] Dynamic subtest vecs0: SUCCESS (0.053s) [76.743878] Starting dynamic subtest: vecs1 [76.765726] Dynamic subtest vecs1: SUCCESS (0.052s) [76.781434] Starting dynamic subtest: ccs0 [76.823109] Dynamic subtest ccs0: SUCCESS (0.057s) [76.848753] Starting dynamic subtest: ccs1 [76.880279] Dynamic subtest ccs1: SUCCESS (0.057s) [76.903956] Starting dynamic subtest: ccs2 [76.937180] Dynamic subtest ccs2: SUCCESS (0.057s) [76.964678] Starting dynamic subtest: ccs3 [76.998517] Dynamic subtest ccs3: SUCCESS (0.062s) [76.999621] Subtest basic-busy: SUCCESS (0.625s) [78.151816] [022/165] (925s left) gem_exec_fence (basic-wait) [78.349449] Starting subtest: basic-wait [78.350583] Starting dynamic subtest: rcs0 [78.473555] Dynamic subtest rcs0: SUCCESS (0.123s) [78.487245] Starting dynamic subtest: bcs0 [78.526565] Dynamic subtest bcs0: SUCCESS (0.054s) [78.544029] Starting dynamic subtest: vcs0 [78.584801] Dynamic subtest vcs0: SUCCESS (0.057s) [78.624495] Starting dynamic subtest: vcs1 [78.641576] Dynamic subtest vcs1: SUCCESS (0.057s) [78.657502] Starting dynamic subtest: vecs0 [78.696728] Dynamic subtest vecs0: SUCCESS (0.055s) [78.717158] Starting dynamic subtest: vecs1 [78.753754] Dynamic subtest vecs1: SUCCESS (0.056s) [78.787695] Starting dynamic subtest: ccs0 [78.806525] Dynamic subtest ccs0: SUCCESS (0.053s) [78.821134] Starting dynamic subtest: ccs1 [78.859118] Dynamic subtest ccs1: SUCCESS (0.052s) [78.882614] Starting dynamic subtest: ccs2 [78.914774] Dynamic subtest ccs2: SUCCESS (0.055s) [78.929120] Starting dynamic subtest: ccs3 [78.965712] Dynamic subtest ccs3: SUCCESS (0.051s) [78.967025] Subtest basic-wait: SUCCESS (0.616s) [80.165378] [023/165] (923s left) gem_exec_fence (basic-await) [80.364631] Starting subtest: basic-await [80.365768] Starting dynamic subtest: rcs0 [80.509117] Dynamic subtest rcs0: SUCCESS (0.145s) [80.519521] Starting dynamic subtest: bcs0 [80.625072] Dynamic subtest bcs0: SUCCESS (0.116s) [80.635567] Starting dynamic subtest: vcs0 [80.741575] Dynamic subtest vcs0: SUCCESS (0.116s) [80.751693] Starting dynamic subtest: vcs1 [80.857710] Dynamic subtest vcs1: SUCCESS (0.116s) [80.868337] Starting dynamic subtest: vecs0 [80.974223] Dynamic subtest vecs0: SUCCESS (0.117s) [80.984553] Starting dynamic subtest: vecs1 [81.089480] Dynamic subtest vecs1: SUCCESS (0.115s) [81.099778] Starting dynamic subtest: ccs0 [81.205062] Dynamic subtest ccs0: SUCCESS (0.115s) [81.215269] Starting dynamic subtest: ccs1 [81.319530] Dynamic subtest ccs1: SUCCESS (0.115s) [81.330693] Starting dynamic subtest: ccs2 [81.438458] Dynamic subtest ccs2: SUCCESS (0.119s) [81.453152] Starting dynamic subtest: ccs3 [81.563353] Dynamic subtest ccs3: SUCCESS (0.125s) [81.564384] Subtest basic-await: SUCCESS (1.199s) [82.716168] [024/165] (921s left) gem_exec_fence (nb-await) [82.959228] Starting subtest: nb-await [82.960856] Starting dynamic subtest: rcs0 [83.066967] Dynamic subtest rcs0: SUCCESS (0.108s) [83.082910] Starting dynamic subtest: bcs0 [83.142237] Dynamic subtest bcs0: SUCCESS (0.074s) [83.180280] Starting dynamic subtest: vcs0 [83.243479] Dynamic subtest vcs0: SUCCESS (0.102s) [83.264435] Starting dynamic subtest: vcs1 [83.328727] Dynamic subtest vcs1: SUCCESS (0.085s) [83.343714] Starting dynamic subtest: vecs0 [83.402538] Dynamic subtest vecs0: SUCCESS (0.073s) [83.437788] Starting dynamic subtest: vecs1 [83.501333] Dynamic subtest vecs1: SUCCESS (0.099s) [83.522780] Starting dynamic subtest: ccs0 [83.586642] Dynamic subtest ccs0: SUCCESS (0.085s) [83.600540] Starting dynamic subtest: ccs1 [83.660928] Dynamic subtest ccs1: SUCCESS (0.073s) [83.699079] Starting dynamic subtest: ccs2 [83.760113] Dynamic subtest ccs2: SUCCESS (0.100s) [83.778756] Starting dynamic subtest: ccs3 [83.839096] Dynamic subtest ccs3: SUCCESS (0.077s) [83.841274] Subtest nb-await: SUCCESS (0.879s) [84.935970] [025/165] (919s left) gem_exec_gttfill (basic) [85.018613] Starting subtest: basic [92.431642] Subtest basic: SUCCESS (7.413s) [92.683008] [026/165] (911s left) gem_exec_parallel (engines) [92.803796] Starting subtest: engines [92.804878] Starting dynamic subtest: basic [94.366820] Dynamic subtest basic: SUCCESS (1.563s) [94.379218] Starting dynamic subtest: contexts [97.496384] Dynamic subtest contexts: SUCCESS (3.129s) [97.507458] Starting dynamic subtest: fds [101.040076] Dynamic subtest fds: SUCCESS (3.543s) [101.051634] Starting dynamic subtest: userptr [102.497915] Dynamic subtest userptr: SUCCESS (1.458s) [102.499116] Subtest engines: SUCCESS (9.694s) [102.811050] [027/165] (901s left) gem_exec_store (basic) [102.893812] Starting subtest: basic [103.046081] Subtest basic: SUCCESS (0.152s) [103.274342] [028/165] (900s left) gem_flink_basic (bad-flink) [103.339989] Starting subtest: bad-flink [103.341078] Subtest bad-flink: SUCCESS (0.000s) [103.422518] [029/165] (900s left) gem_flink_basic (bad-open) [103.498342] Starting subtest: bad-open [103.499522] Subtest bad-open: SUCCESS (0.000s) [103.578174] [030/165] (900s left) gem_flink_basic (basic) [103.644851] Starting subtest: basic [103.645851] Subtest basic: SUCCESS (0.000s) [103.759439] [031/165] (900s left) gem_flink_basic (double-flink) [103.824382] Starting subtest: double-flink [103.825411] Subtest double-flink: SUCCESS (0.000s) [103.906851] [032/165] (900s left) gem_flink_basic (flink-lifetime) [103.972486] Starting subtest: flink-lifetime [103.974581] Subtest flink-lifetime: SUCCESS (0.002s) [104.092147] [033/165] (900s left) gem_huc_copy (huc-copy) [104.198261] Starting subtest: huc-copy [104.204587] Subtest huc-copy: SUCCESS (0.006s) [104.353648] [034/165] (900s left) gem_linear_blits (basic) [104.521130] Starting subtest: basic [104.566696] Subtest basic: SUCCESS (0.046s) [104.711210] [035/165] (899s left) gem_mmap (basic) [104.821191] Subtest basic: SKIP (0.000s) [104.854493] [036/165] (899s left) gem_mmap_gtt (basic) [104.924491] Subtest basic: SKIP (0.000s) [104.954631] [037/165] (899s left) gem_render_linear_blits (basic) [105.029483] Starting subtest: basic [105.116688] Subtest basic: SUCCESS (0.087s) [105.187913] [038/165] (899s left) gem_render_tiled_blits (basic) [105.261451] Subtest basic: SKIP (0.000s) [105.304266] [039/165] (899s left) gem_ringfill (basic-all) [105.739696] Starting subtest: basic-all [109.334085] Subtest basic-all: SUCCESS (3.595s) [109.480292] [040/165] (895s left) gem_softpin (allocator-basic) [109.554807] Starting subtest: allocator-basic [109.807991] Subtest allocator-basic: SUCCESS (0.253s) [109.918453] [041/165] (894s left) gem_softpin (allocator-basic-reserve) [109.997725] Starting subtest: allocator-basic-reserve [110.253074] Subtest allocator-basic-reserve: SUCCESS (0.255s) [110.396043] [042/165] (894s left) gem_softpin (safe-alignment) [110.494288] Starting subtest: safe-alignment [110.565952] Subtest safe-alignment: SUCCESS (0.072s) [110.699934] [043/165] (893s left) gem_sync (basic-all) [110.788123] Starting subtest: basic-all [112.915015] Subtest basic-all: SUCCESS (2.127s) [113.135747] [044/165] (891s left) gem_sync (basic-each) [113.216194] Starting subtest: basic-each [115.907614] Subtest basic-each: SUCCESS (2.691s) [116.142120] [045/165] (888s left) gem_tiled_blits (basic) [116.216196] Subtest basic: SKIP (0.000s) [116.289958] [046/165] (888s left) gem_tiled_fence_blits (basic) [116.369896] Subtest basic: SKIP (0.000s) [116.404782] [047/165] (888s left) gem_tiled_pread_basic [116.504504] [048/165] (888s left) gem_wait (busy@all-engines) [116.588707] Starting subtest: busy [116.589787] Starting dynamic subtest: all-engines [117.178344] Dynamic subtest all-engines: SUCCESS (0.590s) [117.179406] Subtest busy: SUCCESS (0.590s) [117.484499] [049/165] (887s left) gem_wait (wait@all-engines) [117.567965] Starting subtest: wait [117.569119] Starting dynamic subtest: all-engines [118.664826] Dynamic subtest all-engines: SUCCESS (1.096s) [118.666295] Subtest wait: SUCCESS (1.097s) [118.952768] [050/165] (885s left) i915_getparams_basic (basic-eu-total) [119.018461] Starting subtest: basic-eu-total [119.020869] Subtest basic-eu-total: SUCCESS (0.000s) [119.094808] [051/165] (885s left) i915_getparams_basic (basic-subslice-total) [119.165878] Starting subtest: basic-subslice-total [119.167866] Subtest basic-subslice-total: SUCCESS (0.000s) [119.236445] [052/165] (885s left) i915_hangman (error-state-basic) [119.338826] Starting subtest: error-state-basic [119.529938] Subtest error-state-basic: SUCCESS (0.191s) [119.623791] [053/165] (885s left) i915_pciid [119.784981] [054/165] (885s left) kms_addfb_basic (addfb25-4-tiled) [119.936448] Starting subtest: addfb25-4-tiled [119.937531] Subtest addfb25-4-tiled: SUCCESS (0.000s) [120.018295] [055/165] (884s left) kms_addfb_basic (addfb25-bad-modifier) [120.085413] Starting subtest: addfb25-bad-modifier [120.086514] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [120.250935] [056/165] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [120.326745] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [120.486317] [057/165] (884s left) kms_addfb_basic (addfb25-modifier-no-flag) [120.559231] Starting subtest: addfb25-modifier-no-flag [120.560363] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [120.720857] [058/165] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy) [120.799542] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [120.934466] [059/165] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [121.005577] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [121.150716] [060/165] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [121.280735] Starting subtest: addfb25-yf-tiled-legacy [121.281721] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [121.368903] [061/165] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy) [121.503257] Starting subtest: addfb25-y-tiled-legacy [121.504300] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [121.584984] [062/165] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [121.717425] Starting subtest: addfb25-y-tiled-small-legacy [121.719508] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [121.827226] [063/165] (883s left) kms_addfb_basic (bad-pitch-0) [121.909045] Starting subtest: bad-pitch-0 [121.910186] Subtest bad-pitch-0: SUCCESS (0.000s) [122.073800] [064/165] (883s left) kms_addfb_basic (bad-pitch-1024) [122.158597] Starting subtest: bad-pitch-1024 [122.159716] Subtest bad-pitch-1024: SUCCESS (0.000s) [122.317733] [065/165] (882s left) kms_addfb_basic (bad-pitch-128) [122.386354] Starting subtest: bad-pitch-128 [122.387419] Subtest bad-pitch-128: SUCCESS (0.000s) [122.551269] [066/165] (882s left) kms_addfb_basic (bad-pitch-256) [122.619396] Starting subtest: bad-pitch-256 [122.620400] Subtest bad-pitch-256: SUCCESS (0.000s) [122.769550] [067/165] (882s left) kms_addfb_basic (bad-pitch-32) [122.840782] Starting subtest: bad-pitch-32 [122.841856] Subtest bad-pitch-32: SUCCESS (0.000s) [123.009076] [068/165] (882s left) kms_addfb_basic (bad-pitch-63) [123.088509] Starting subtest: bad-pitch-63 [123.089628] Subtest bad-pitch-63: SUCCESS (0.000s) [123.234768] [069/165] (882s left) kms_addfb_basic (bad-pitch-65536) [123.302979] Starting subtest: bad-pitch-65536 [123.304137] Subtest bad-pitch-65536: SUCCESS (0.000s) [123.452874] [070/165] (881s left) kms_addfb_basic (bad-pitch-999) [123.522490] Starting subtest: bad-pitch-999 [123.523561] Subtest bad-pitch-999: SUCCESS (0.000s) [123.690578] [071/165] (881s left) kms_addfb_basic (basic) [123.769419] Starting subtest: basic [123.770526] Subtest basic: SUCCESS (0.000s) [123.917749] [072/165] (881s left) kms_addfb_basic (basic-x-tiled-legacy) [123.987623] Starting subtest: basic-x-tiled-legacy [123.989692] Subtest basic-x-tiled-legacy: SKIP (0.000s) [124.134664] [073/165] (881s left) kms_addfb_basic (basic-y-tiled-legacy) [124.202789] Starting subtest: basic-y-tiled-legacy [124.204822] Subtest basic-y-tiled-legacy: SKIP (0.000s) [124.367738] [074/165] (880s left) kms_addfb_basic (bo-too-small) [124.507387] Starting subtest: bo-too-small [124.508439] Subtest bo-too-small: SUCCESS (0.000s) [124.584830] [075/165] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling) [124.717190] Starting subtest: bo-too-small-due-to-tiling [124.719288] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [124.801886] [076/165] (880s left) kms_addfb_basic (clobberred-modifier) [124.869296] Starting subtest: clobberred-modifier [124.871363] Subtest clobberred-modifier: SKIP (0.000s) [125.019237] [077/165] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling) [125.090616] Starting subtest: framebuffer-vs-set-tiling [125.092749] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [125.234731] [078/165] (880s left) kms_addfb_basic (invalid-get-prop) [125.302670] Starting subtest: invalid-get-prop [125.303731] Subtest invalid-get-prop: SUCCESS (0.000s) [125.472863] [079/165] (879s left) kms_addfb_basic (invalid-get-prop-any) [125.562545] Starting subtest: invalid-get-prop-any [125.563547] Subtest invalid-get-prop-any: SUCCESS (0.000s) [125.753580] [080/165] (879s left) kms_addfb_basic (invalid-set-prop) [125.834228] Starting subtest: invalid-set-prop [125.835241] Subtest invalid-set-prop: SUCCESS (0.000s) [125.967633] [081/165] (879s left) kms_addfb_basic (invalid-set-prop-any) [126.036511] Starting subtest: invalid-set-prop-any [126.037550] Subtest invalid-set-prop-any: SUCCESS (0.000s) [126.186473] [082/165] (879s left) kms_addfb_basic (no-handle) [126.256449] Starting subtest: no-handle [126.257514] Subtest no-handle: SUCCESS (0.000s) [126.401570] [083/165] (879s left) kms_addfb_basic (size-max) [126.533367] Starting subtest: size-max [126.534470] Subtest size-max: SUCCESS (0.000s) [126.619086] [084/165] (878s left) kms_addfb_basic (small-bo) [126.753896] Starting subtest: small-bo [126.755062] Subtest small-bo: SUCCESS (0.000s) [126.856770] [085/165] (878s left) kms_addfb_basic (tile-pitch-mismatch) [126.936864] Starting subtest: tile-pitch-mismatch [126.938981] Subtest tile-pitch-mismatch: SKIP (0.000s) [127.085861] [086/165] (878s left) kms_addfb_basic (too-high) [127.228731] Starting subtest: too-high [127.229888] Subtest too-high: SUCCESS (0.001s) [127.317654] [087/165] (878s left) kms_addfb_basic (too-wide) [127.450256] Starting subtest: too-wide [127.451418] Subtest too-wide: SUCCESS (0.000s) [127.533907] [088/165] (878s left) kms_addfb_basic (unused-handle) [127.600513] Starting subtest: unused-handle [127.601612] Subtest unused-handle: SUCCESS (0.000s) [127.752513] [089/165] (877s left) kms_addfb_basic (unused-modifier) [127.822498] Starting subtest: unused-modifier [127.823571] Subtest unused-modifier: SUCCESS (0.000s) [127.967693] [090/165] (877s left) kms_addfb_basic (unused-offsets) [128.034935] Starting subtest: unused-offsets [128.036103] Subtest unused-offsets: SUCCESS (0.000s) [128.186099] [091/165] (877s left) kms_addfb_basic (unused-pitches) [128.255903] Starting subtest: unused-pitches [128.256976] Subtest unused-pitches: SUCCESS (0.000s) [128.401230] [092/165] (877s left) kms_busy (basic) [128.540356] Starting subtest: basic [128.541432] Starting dynamic subtest: flip [129.284734] Dynamic subtest flip: SUCCESS (0.744s) [129.299298] Starting dynamic subtest: modeset [130.343428] Dynamic subtest modeset: SUCCESS (1.058s) [130.344490] Subtest basic: SUCCESS (1.804s) [130.636869] [093/165] (875s left) kms_prop_blob (basic) [130.720544] Starting subtest: basic [130.721567] Subtest basic: SUCCESS (0.000s) [130.785474] [094/165] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [130.915090] Starting subtest: basic-busy-flip-before-cursor-atomic [130.917210] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [130.984337] [095/165] (874s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [131.115604] Starting subtest: basic-busy-flip-before-cursor-legacy [131.117651] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [131.184490] [096/165] (874s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [131.323544] Starting subtest: basic-flip-after-cursor-atomic [132.399510] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.076s) [132.655735] [097/165] (873s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [132.806272] Starting subtest: basic-flip-after-cursor-legacy [133.903410] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.097s) [134.150860] [098/165] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [134.300547] Starting subtest: basic-flip-after-cursor-varying-size [135.385272] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.086s) [135.630651] [099/165] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [135.775065] Starting subtest: basic-flip-before-cursor-atomic [136.848882] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.074s) [137.093750] [100/165] (868s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [137.230812] Starting subtest: basic-flip-before-cursor-legacy [138.311466] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.082s) [138.545123] [101/165] (867s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [138.681146] Starting subtest: basic-flip-before-cursor-varying-size [139.762624] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.082s) [140.006535] [102/165] (866s left) kms_dsc (dsc-basic) [140.162495] Subtest dsc-basic: SKIP (0.000s) [140.215258] [103/165] (865s left) kms_flip (basic-flip-vs-dpms) [140.346201] Starting subtest: basic-flip-vs-dpms [140.352464] Starting dynamic subtest: A-DP1 [141.288669] Dynamic subtest A-DP1: SUCCESS (0.935s) [141.303369] Starting dynamic subtest: B-DP1 [142.242988] Dynamic subtest B-DP1: SUCCESS (0.954s) [142.256463] Starting dynamic subtest: C-DP1 [143.169454] Dynamic subtest C-DP1: SUCCESS (0.923s) [143.182908] Starting dynamic subtest: D-DP1 [144.129145] Dynamic subtest D-DP1: SUCCESS (0.962s) [144.133661] Subtest basic-flip-vs-dpms: SUCCESS (3.788s) [144.391477] [104/165] (861s left) kms_flip (basic-flip-vs-modeset) [144.537459] Starting subtest: basic-flip-vs-modeset [144.543562] Starting dynamic subtest: A-DP1 [145.478426] Dynamic subtest A-DP1: SUCCESS (0.933s) [145.501779] Starting dynamic subtest: B-DP1 [146.430737] Dynamic subtest B-DP1: SUCCESS (0.952s) [146.446531] Starting dynamic subtest: C-DP1 [147.382366] Dynamic subtest C-DP1: SUCCESS (0.951s) [147.397194] Starting dynamic subtest: D-DP1 [148.327804] Dynamic subtest D-DP1: SUCCESS (0.944s) [148.337552] Subtest basic-flip-vs-modeset: SUCCESS (3.796s) [148.587106] [105/165] (857s left) kms_flip (basic-flip-vs-wf_vblank) [148.748567] Starting subtest: basic-flip-vs-wf_vblank [148.758726] Starting dynamic subtest: A-DP1 [149.992370] Dynamic subtest A-DP1: SUCCESS (1.233s) [150.016597] Starting dynamic subtest: B-DP1 [151.162352] Dynamic subtest B-DP1: SUCCESS (1.167s) [151.177988] Starting dynamic subtest: C-DP1 [152.286433] Dynamic subtest C-DP1: SUCCESS (1.123s) [152.302076] Starting dynamic subtest: D-DP1 [153.408898] Dynamic subtest D-DP1: SUCCESS (1.121s) [153.415063] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.667s) [153.737245] [106/165] (852s left) kms_flip (basic-plain-flip) [153.880468] Starting subtest: basic-plain-flip [153.892606] Starting dynamic subtest: A-DP1 [154.834631] Dynamic subtest A-DP1: SUCCESS (0.942s) [154.853411] Starting dynamic subtest: B-DP1 [155.673786] Dynamic subtest B-DP1: SUCCESS (0.837s) [155.689528] Starting dynamic subtest: C-DP1 [156.511362] Dynamic subtest C-DP1: SUCCESS (0.836s) [156.527601] Starting dynamic subtest: D-DP1 [157.351102] Dynamic subtest D-DP1: SUCCESS (0.838s) [157.357582] Subtest basic-plain-flip: SUCCESS (3.477s) [157.677905] [107/165] (848s left) kms_force_connector_basic (force-connector-state) [157.762847] Starting subtest: force-connector-state [157.997844] Subtest force-connector-state: SUCCESS (0.235s) [158.277277] [108/165] (847s left) kms_force_connector_basic (force-edid) [158.349281] Starting subtest: force-edid [158.366583] Subtest force-edid: SUCCESS (0.017s) [158.560743] [109/165] (847s left) kms_force_connector_basic (force-load-detect) [158.630768] Starting subtest: force-load-detect [158.632562] Subtest force-load-detect: SKIP (0.000s) [158.760433] [110/165] (847s left) kms_force_connector_basic (prune-stale-modes) [158.832577] Starting subtest: prune-stale-modes [158.841672] Subtest prune-stale-modes: SKIP (0.009s) [159.010442] [111/165] (847s left) kms_frontbuffer_tracking (basic) [159.148779] Starting subtest: basic [162.784159] Subtest basic: SUCCESS (3.635s) [162.956704] [112/165] (843s left) kms_hdmi_inject (inject-audio) [163.109531] Starting subtest: inject-audio [163.228317] Subtest inject-audio: SUCCESS (0.118s) [163.590978] [113/165] (842s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [163.723545] Starting subtest: compare-crc-sanitycheck-xr24 [163.724604] Starting dynamic subtest: pipe-A-DP-1 [164.323930] Dynamic subtest pipe-A-DP-1: SUCCESS (0.599s) [164.346695] Starting dynamic subtest: pipe-B-DP-1 [164.878555] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s) [164.893844] Starting dynamic subtest: pipe-C-DP-1 [165.444022] Dynamic subtest pipe-C-DP-1: SUCCESS (0.563s) [165.462386] Starting dynamic subtest: pipe-D-DP-1 [166.019287] Dynamic subtest pipe-D-DP-1: SUCCESS (0.572s) [166.020307] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.297s) [166.261990] [114/165] (840s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [166.404784] Starting subtest: compare-crc-sanitycheck-nv12 [166.407393] Starting dynamic subtest: pipe-A-DP-1 [167.703512] Dynamic subtest pipe-A-DP-1: SUCCESS (1.296s) [167.718986] Starting dynamic subtest: pipe-B-DP-1 [168.928642] Dynamic subtest pipe-B-DP-1: SUCCESS (1.223s) [168.943930] Starting dynamic subtest: pipe-C-DP-1 [170.142430] Dynamic subtest pipe-C-DP-1: SUCCESS (1.211s) [170.158275] Starting dynamic subtest: pipe-D-DP-1 [171.289245] Dynamic subtest pipe-D-DP-1: SUCCESS (1.144s) [171.290374] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.884s) [171.556190] [115/165] (834s left) kms_pipe_crc_basic (hang-read-crc) [171.701267] Starting subtest: hang-read-crc [171.702355] Starting dynamic subtest: pipe-A-DP-1 [173.417820] Dynamic subtest pipe-A-DP-1: SUCCESS (1.715s) [173.433483] Starting dynamic subtest: pipe-B-DP-1 [175.002966] Dynamic subtest pipe-B-DP-1: SUCCESS (1.582s) [175.018750] Starting dynamic subtest: pipe-C-DP-1 [176.669390] Dynamic subtest pipe-C-DP-1: SUCCESS (1.665s) [176.685539] Starting dynamic subtest: pipe-D-DP-1 [178.204628] Dynamic subtest pipe-D-DP-1: SUCCESS (1.531s) [178.205692] Subtest hang-read-crc: SUCCESS (6.505s) [178.489704] [116/165] (827s left) kms_pipe_crc_basic (nonblocking-crc) [178.639253] Starting subtest: nonblocking-crc [178.640357] Starting dynamic subtest: pipe-A-DP-1 [179.435023] Dynamic subtest pipe-A-DP-1: SUCCESS (0.795s) [179.454523] Starting dynamic subtest: pipe-B-DP-1 [180.150560] Dynamic subtest pipe-B-DP-1: SUCCESS (0.712s) [180.166029] Starting dynamic subtest: pipe-C-DP-1 [180.882541] Dynamic subtest pipe-C-DP-1: SUCCESS (0.729s) [180.898065] Starting dynamic subtest: pipe-D-DP-1 [181.587584] Dynamic subtest pipe-D-DP-1: SUCCESS (0.702s) [181.588608] Subtest nonblocking-crc: SUCCESS (2.950s) [181.871208] [117/165] (824s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [182.009480] Starting subtest: nonblocking-crc-frame-sequence [182.010546] Starting dynamic subtest: pipe-A-DP-1 [182.802522] Dynamic subtest pipe-A-DP-1: SUCCESS (0.792s) [182.818251] Starting dynamic subtest: pipe-B-DP-1 [183.496390] Dynamic subtest pipe-B-DP-1: SUCCESS (0.691s) [183.511677] Starting dynamic subtest: pipe-C-DP-1 [184.230461] Dynamic subtest pipe-C-DP-1: SUCCESS (0.731s) [184.245723] Starting dynamic subtest: pipe-D-DP-1 [184.949843] Dynamic subtest pipe-D-DP-1: SUCCESS (0.717s) [184.950931] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.942s) [185.202158] [118/165] (821s left) kms_pipe_crc_basic (read-crc) [185.349205] Starting subtest: read-crc [185.352155] Starting dynamic subtest: pipe-A-DP-1 [186.078240] Dynamic subtest pipe-A-DP-1: SUCCESS (0.727s) [186.093992] Starting dynamic subtest: pipe-B-DP-1 [186.742567] Dynamic subtest pipe-B-DP-1: SUCCESS (0.661s) [186.758262] Starting dynamic subtest: pipe-C-DP-1 [187.458974] Dynamic subtest pipe-C-DP-1: SUCCESS (0.713s) [187.474480] Starting dynamic subtest: pipe-D-DP-1 [188.111520] Dynamic subtest pipe-D-DP-1: SUCCESS (0.650s) [188.112596] Subtest read-crc: SUCCESS (2.763s) [188.358327] [119/165] (818s left) kms_pipe_crc_basic (read-crc-frame-sequence) [188.498015] Starting subtest: read-crc-frame-sequence [188.498971] Starting dynamic subtest: pipe-A-DP-1 [189.253536] Dynamic subtest pipe-A-DP-1: SUCCESS (0.750s) [189.267616] Starting dynamic subtest: pipe-B-DP-1 [189.911815] Dynamic subtest pipe-B-DP-1: SUCCESS (0.658s) [189.926024] Starting dynamic subtest: pipe-C-DP-1 [190.577152] Dynamic subtest pipe-C-DP-1: SUCCESS (0.664s) [190.593122] Starting dynamic subtest: pipe-D-DP-1 [191.251913] Dynamic subtest pipe-D-DP-1: SUCCESS (0.671s) [191.252880] Subtest read-crc-frame-sequence: SUCCESS (2.755s) [191.504679] [120/165] (815s left) kms_pm_backlight (basic-brightness) [191.651659] Subtest basic-brightness: SKIP (0.000s) [191.688266] [121/165] (815s left) kms_pm_rpm (basic-pci-d3-state) [193.575161] Starting subtest: basic-pci-d3-state [194.174717] Subtest basic-pci-d3-state: SUCCESS (0.601s) [194.386264] [122/165] (812s left) kms_pm_rpm (basic-rte) [194.469194] Starting subtest: basic-rte [197.052839] Subtest basic-rte: SUCCESS (2.581s) [197.655741] [123/165] (809s left) kms_psr (psr_primary_page_flip) [197.793848] Subtest psr_primary_page_flip: SKIP (0.000s) [197.823719] [124/165] (808s left) kms_psr (psr_cursor_plane_move) [197.958030] Subtest psr_cursor_plane_move: SKIP (0.000s) [197.990723] [125/165] (808s left) kms_psr (psr_sprite_plane_onoff) [198.126142] Subtest psr_sprite_plane_onoff: SKIP (0.000s) [198.157412] [126/165] (808s left) kms_psr (psr_primary_mmap_gtt) [198.288731] Subtest psr_primary_mmap_gtt: SKIP (0.000s) [198.324381] [127/165] (808s left) kms_setmode (basic-clone-single-crtc) [198.393459] Starting subtest: basic-clone-single-crtc [198.396685] Subtest basic-clone-single-crtc: SKIP (0.001s) [198.473787] [128/165] (808s left) i915_pm_rps (basic-api) [198.558056] Starting subtest: basic-api [198.560193] Subtest basic-api: SKIP (0.000s) [198.640448] [129/165] (808s left) prime_self_import (basic-llseek-bad) [198.711983] Starting subtest: basic-llseek-bad [198.715572] Subtest basic-llseek-bad: SUCCESS (0.002s) [198.816929] [130/165] (808s left) prime_self_import (basic-llseek-size) [198.891072] Starting subtest: basic-llseek-size [198.894866] Subtest basic-llseek-size: SUCCESS (0.004s) [199.026164] [131/165] (807s left) prime_self_import (basic-with_fd_dup) [199.094712] Starting subtest: basic-with_fd_dup [199.098714] Subtest basic-with_fd_dup: SUCCESS (0.004s) [199.200060] [132/165] (807s left) prime_self_import (basic-with_one_bo) [199.277992] Starting subtest: basic-with_one_bo [199.281954] Subtest basic-with_one_bo: SUCCESS (0.004s) [199.340788] [133/165] (807s left) prime_self_import (basic-with_one_bo_two_files) [199.405887] Starting subtest: basic-with_one_bo_two_files [199.411066] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [199.529203] [134/165] (807s left) prime_self_import (basic-with_two_bos) [199.603545] Starting subtest: basic-with_two_bos [199.607105] Subtest basic-with_two_bos: SUCCESS (0.004s) [199.759978] [135/165] (807s left) prime_vgem (basic-fence-flip) [199.862109] Starting subtest: basic-fence-flip [199.976582] Subtest basic-fence-flip: SKIP (0.114s) [200.107662] [136/165] (807s left) prime_vgem (basic-fence-mmap) [200.203920] Starting subtest: basic-fence-mmap [200.206127] Subtest basic-fence-mmap: SKIP (0.000s) [200.361472] [137/165] (806s left) prime_vgem (basic-fence-read) [200.463851] Starting subtest: basic-fence-read [200.470583] Subtest basic-fence-read: SKIP (0.006s) [200.603510] [138/165] (806s left) prime_vgem (basic-gtt) [200.726555] Starting subtest: basic-gtt [200.728921] Subtest basic-gtt: SKIP (0.000s) [200.856416] [139/165] (806s left) prime_vgem (basic-read) [200.950461] Starting subtest: basic-read [200.957493] Subtest basic-read: SKIP (0.006s) [201.080139] [140/165] (806s left) prime_vgem (basic-write) [201.166687] Starting subtest: basic-write [201.173435] Subtest basic-write: SKIP (0.006s) [201.289677] [141/165] (806s left) vgem_basic (setversion) [201.374853] Starting subtest: setversion [201.377147] Subtest setversion: SUCCESS (0.000s) [201.445491] [142/165] (805s left) vgem_basic (create) [201.541489] Starting subtest: create [201.542559] Subtest create: SUCCESS (0.000s) [201.605361] [143/165] (805s left) vgem_basic (debugfs) [201.691453] Starting subtest: debugfs [201.694258] Subtest debugfs: SUCCESS (0.001s) [201.756218] [144/165] (805s left) vgem_basic (dmabuf-export) [201.824926] Starting subtest: dmabuf-export [201.827309] Subtest dmabuf-export: SUCCESS (0.003s) [201.946802] [145/165] (805s left) vgem_basic (dmabuf-fence) [202.024761] Starting subtest: dmabuf-fence [202.025869] Subtest dmabuf-fence: SUCCESS (0.000s) [202.087370] [146/165] (805s left) vgem_basic (dmabuf-fence-before) [202.158146] Starting subtest: dmabuf-fence-before [202.159208] Subtest dmabuf-fence-before: SUCCESS (0.000s) [202.219064] [147/165] (805s left) vgem_basic (dmabuf-mmap) [202.291477] Starting subtest: dmabuf-mmap [202.303979] Subtest dmabuf-mmap: SUCCESS (0.013s) [202.371725] [148/165] (805s left) vgem_basic (mmap) [202.442035] Starting subtest: mmap [202.449512] Subtest mmap: SUCCESS (0.008s) [202.502833] [149/165] (805s left) vgem_basic (second-client) [202.574868] Starting subtest: second-client [202.608223] Subtest second-client: SUCCESS (0.033s) [202.697550] [150/165] (804s left) vgem_basic (sysfs) [202.774872] Starting subtest: sysfs [202.775962] Subtest sysfs: SUCCESS (0.000s) [202.838156] [151/165] (804s left) core_hotunplug (unbind-rebind) [202.941220] Starting subtest: unbind-rebind [209.394402] Subtest unbind-rebind: SUCCESS (6.453s) [209.411698] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1809 [max: 8192] direct dependencies: 18166 [max: 32768] indirect dependencies: 144541 all direct dependencies: 374606 dependency chains: 25616 [max: 131072] dependency chain hlocks used: 109183 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 319 in-softirq chains: 580 in-process chains: 24717 stack-trace entries: 174208 [max: 1048576] number of stack traces: 8836 number of stack hash chains: 6816 combined max dependencies: 300603264 hardirq-safe locks: 107 hardirq-unsafe locks: 1064 softirq-safe locks: 209 softirq-unsafe locks: 976 irq-safe locks: 228 irq-unsafe locks: 1064 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 323 softirq-read-safe locks: 7 softirq-read-unsafe locks: 318 irq-read-safe locks: 7 irq-read-unsafe locks: 323 uncategorized locks: 304 unused locks: 1 max locking depth: 15 max bfs queue depth: 419 max lock class index: 2007 chain lookup misses: 30041 chain lookup hits: 187198071 cyclic checks: 30279 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4762 find-mask backwards checks: 3087 hardirq on events: 102302893 hardirq off events: 102302885 redundant hardirq ons: 38 redundant hardirq offs: 28 softirq on events: 576379 softirq off events: 576379 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 203 zapped lock chains: 4194 large chain blocks: 1 [209.412929] Closing watchdogs Done.