[40.450657] Initializing watchdogs [40.450703] /dev/watchdog0 [40.461347] [001/171] (960s left) i915_module_load (load) [40.503073] Starting subtest: load [43.421507] Subtest load: SUCCESS (2.919s) [43.433200] [002/171] (957s left) core_auth (basic-auth) [43.551393] Starting subtest: basic-auth [43.552206] Subtest basic-auth: SUCCESS (0.001s) [43.603886] [003/171] (957s left) debugfs_test (read_all_entries) [43.662698] Starting subtest: read_all_entries [44.838306] Subtest read_all_entries: SUCCESS (1.176s) [44.938647] [004/171] (956s left) debugfs_test (basic-hwmon) [44.995316] Starting subtest: basic-hwmon [44.997740] Subtest basic-hwmon: SUCCESS (0.002s) [45.087406] [005/171] (955s left) fbdev (eof) [45.138284] Starting subtest: eof [45.139021] Subtest eof: SUCCESS (0.000s) [45.189199] [006/171] (955s left) fbdev (info) [45.229033] Starting subtest: info [45.229745] Subtest info: SUCCESS (0.000s) [45.287206] [007/171] (955s left) fbdev (nullptr) [45.338033] Starting subtest: nullptr [45.338825] Subtest nullptr: SUCCESS (0.000s) [45.388060] [008/171] (955s left) fbdev (read) [45.438685] Starting subtest: read [58.535973] Subtest read: SUCCESS (13.087s) [58.570576] [009/171] (942s left) fbdev (write) [58.622675] Starting subtest: write [67.355145] Subtest write: SUCCESS (8.733s) [67.404731] [010/171] (933s left) gem_basic (bad-close) [67.458507] Starting subtest: bad-close [67.459915] Subtest bad-close: SUCCESS (0.000s) [67.520756] [011/171] (933s left) gem_basic (create-close) [67.577579] Starting subtest: create-close [67.579048] Subtest create-close: SUCCESS (0.000s) [67.654920] [012/171] (933s left) gem_basic (create-fd-close) [67.706570] Starting subtest: create-fd-close [67.708142] Subtest create-fd-close: SUCCESS (0.000s) [67.787230] [013/171] (933s left) gem_busy (busy@all-engines) [67.847606] Starting subtest: busy [67.848350] Starting dynamic subtest: all-engines [67.911926] Dynamic subtest all-engines: SUCCESS (0.064s) [67.912694] Subtest busy: SUCCESS (0.064s) [68.260946] [014/171] (932s left) gem_close_race (basic-process) [68.329135] Starting subtest: basic-process [68.371932] Subtest basic-process: SUCCESS (0.042s) [68.578377] [015/171] (932s left) gem_close_race (basic-threads) [68.646077] Starting subtest: basic-threads [69.842654] Subtest basic-threads: SUCCESS (1.195s) [70.049681] [016/171] (931s left) gem_ctx_create (basic) [70.099903] Starting subtest: basic [70.100727] Subtest basic: SUCCESS (0.000s) [70.278749] [017/171] (930s left) gem_ctx_create (basic-files) [70.326139] Starting subtest: basic-files [72.332544] Subtest basic-files: SUCCESS (2.007s) [73.335123] [018/171] (927s left) gem_ctx_exec (basic) [73.383468] Starting subtest: basic [73.389140] Subtest basic: SUCCESS (0.006s) [73.462862] [019/171] (927s left) gem_exec_basic (basic) [73.508422] Starting subtest: basic [73.509319] Starting dynamic subtest: rcs0-smem [73.510209] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [73.513723] Starting dynamic subtest: bcs0-smem [73.514686] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [73.518122] Starting dynamic subtest: vcs0-smem [73.519135] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [73.522529] Starting dynamic subtest: vcs1-smem [73.523600] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [73.526831] Starting dynamic subtest: vecs0-smem [73.527798] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [73.530962] Starting dynamic subtest: vecs1-smem [73.531948] Dynamic subtest vecs1-smem: SUCCESS (0.000s) [73.535297] Starting dynamic subtest: ccs0-smem [73.536222] Dynamic subtest ccs0-smem: SUCCESS (0.000s) [73.539460] Starting dynamic subtest: rcs0-lmem0 [73.540467] Dynamic subtest rcs0-lmem0: SUCCESS (0.000s) [73.543776] Starting dynamic subtest: bcs0-lmem0 [73.545133] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [73.548627] Starting dynamic subtest: vcs0-lmem0 [73.549904] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [73.553556] Starting dynamic subtest: vcs1-lmem0 [73.554589] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [73.557880] Starting dynamic subtest: vecs0-lmem0 [73.558897] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [73.562183] Starting dynamic subtest: vecs1-lmem0 [73.563546] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [73.567149] Starting dynamic subtest: ccs0-lmem0 [73.568293] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [73.569201] Subtest basic: SUCCESS (0.007s) [73.694857] [020/171] (927s left) gem_exec_create (basic) [73.742683] Starting subtest: basic [73.743425] Starting dynamic subtest: smem [75.834880] Dynamic subtest smem: SUCCESS (2.092s) [75.842527] Starting dynamic subtest: lmem0 [77.931838] Dynamic subtest lmem0: SUCCESS (2.097s) [77.933076] Subtest basic: SUCCESS (4.189s) [78.110182] [021/171] (923s left) gem_exec_fence (basic-busy) [78.274363] Starting subtest: basic-busy [78.275694] Starting dynamic subtest: rcs0 [78.376524] Dynamic subtest rcs0: SUCCESS (0.103s) [78.380288] Starting dynamic subtest: bcs0 [78.428664] Dynamic subtest bcs0: SUCCESS (0.052s) [78.432196] Starting dynamic subtest: vcs0 [78.489538] Dynamic subtest vcs0: SUCCESS (0.061s) [78.493094] Starting dynamic subtest: vcs1 [78.554526] Dynamic subtest vcs1: SUCCESS (0.065s) [78.558111] Starting dynamic subtest: vecs0 [78.605573] Dynamic subtest vecs0: SUCCESS (0.051s) [78.609190] Starting dynamic subtest: vecs1 [78.664826] Dynamic subtest vecs1: SUCCESS (0.059s) [78.668391] Starting dynamic subtest: ccs0 [78.723531] Dynamic subtest ccs0: SUCCESS (0.059s) [78.724250] Subtest basic-busy: SUCCESS (0.450s) [79.273130] [022/171] (921s left) gem_exec_fence (basic-wait) [79.434252] Starting subtest: basic-wait [79.435564] Starting dynamic subtest: rcs0 [79.537608] Dynamic subtest rcs0: SUCCESS (0.104s) [79.546167] Starting dynamic subtest: bcs0 [79.593256] Dynamic subtest bcs0: SUCCESS (0.056s) [79.604083] Starting dynamic subtest: vcs0 [79.646467] Dynamic subtest vcs0: SUCCESS (0.053s) [79.657868] Starting dynamic subtest: vcs1 [79.700468] Dynamic subtest vcs1: SUCCESS (0.054s) [79.709529] Starting dynamic subtest: vecs0 [79.750814] Dynamic subtest vecs0: SUCCESS (0.050s) [79.761279] Starting dynamic subtest: vecs1 [79.801837] Dynamic subtest vecs1: SUCCESS (0.050s) [79.815930] Starting dynamic subtest: ccs0 [79.853297] Dynamic subtest ccs0: SUCCESS (0.052s) [79.855587] Subtest basic-wait: SUCCESS (0.420s) [80.411933] [023/171] (920s left) gem_exec_fence (basic-await) [80.573859] Starting subtest: basic-await [80.575229] Starting dynamic subtest: rcs0 [80.657996] Dynamic subtest rcs0: SUCCESS (0.084s) [80.663121] Starting dynamic subtest: bcs0 [80.728203] Dynamic subtest bcs0: SUCCESS (0.070s) [80.735578] Starting dynamic subtest: vcs0 [80.801598] Dynamic subtest vcs0: SUCCESS (0.073s) [80.809132] Starting dynamic subtest: vcs1 [80.873186] Dynamic subtest vcs1: SUCCESS (0.071s) [80.881891] Starting dynamic subtest: vecs0 [80.946599] Dynamic subtest vecs0: SUCCESS (0.073s) [80.954382] Starting dynamic subtest: vecs1 [81.020813] Dynamic subtest vecs1: SUCCESS (0.073s) [81.030915] Starting dynamic subtest: ccs0 [81.095098] Dynamic subtest ccs0: SUCCESS (0.074s) [81.097387] Subtest basic-await: SUCCESS (0.520s) [81.645684] [024/171] (919s left) gem_exec_fence (nb-await) [81.821596] Starting subtest: nb-await [81.822435] Starting dynamic subtest: rcs0 [81.891926] Dynamic subtest rcs0: SUCCESS (0.080s) [81.896217] Starting dynamic subtest: bcs0 [81.952967] Dynamic subtest bcs0: SUCCESS (0.060s) [81.960098] Starting dynamic subtest: vcs0 [82.016714] Dynamic subtest vcs0: SUCCESS (0.064s) [82.025752] Starting dynamic subtest: vcs1 [82.082108] Dynamic subtest vcs1: SUCCESS (0.064s) [82.089152] Starting dynamic subtest: vecs0 [82.145745] Dynamic subtest vecs0: SUCCESS (0.064s) [82.154946] Starting dynamic subtest: vecs1 [82.211658] Dynamic subtest vecs1: SUCCESS (0.065s) [82.215743] Starting dynamic subtest: ccs0 [82.272096] Dynamic subtest ccs0: SUCCESS (0.060s) [82.273945] Subtest nb-await: SUCCESS (0.460s) [82.811800] [025/171] (918s left) gem_exec_gttfill (basic) [82.862115] Starting subtest: basic [86.697633] Subtest basic: SUCCESS (3.826s) [86.954363] [026/171] (914s left) gem_exec_parallel (engines) [87.035962] Starting subtest: engines [87.037062] Starting dynamic subtest: basic [90.147030] Dynamic subtest basic: SUCCESS (3.111s) [90.151734] Starting dynamic subtest: contexts [92.841302] Dynamic subtest contexts: SUCCESS (2.693s) [92.849164] Starting dynamic subtest: fds [95.515624] Dynamic subtest fds: SUCCESS (2.665s) [95.521331] Starting dynamic subtest: userptr [97.042401] Dynamic subtest userptr: SUCCESS (1.536s) [97.044425] Subtest engines: SUCCESS (10.006s) [97.246883] [027/171] (903s left) gem_exec_store (basic) [97.292461] Starting subtest: basic [97.414421] Subtest basic: SUCCESS (0.121s) [97.611560] [028/171] (903s left) gem_flink_basic (bad-flink) [97.656062] Starting subtest: bad-flink [97.656922] Subtest bad-flink: SUCCESS (0.000s) [97.725224] [029/171] (903s left) gem_flink_basic (bad-open) [97.769098] Starting subtest: bad-open [97.770198] Subtest bad-open: SUCCESS (0.000s) [97.821104] [030/171] (903s left) gem_flink_basic (basic) [97.866719] Starting subtest: basic [97.867744] Subtest basic: SUCCESS (0.000s) [97.941494] [031/171] (903s left) gem_flink_basic (double-flink) [97.984262] Starting subtest: double-flink [97.985180] Subtest double-flink: SUCCESS (0.000s) [98.058568] [032/171] (903s left) gem_flink_basic (flink-lifetime) [98.102291] Starting subtest: flink-lifetime [98.103195] Subtest flink-lifetime: SUCCESS (0.001s) [98.193307] [033/171] (903s left) gem_huc_copy (huc-copy) [98.252163] Starting subtest: huc-copy [98.256759] Subtest huc-copy: SUCCESS (0.005s) [98.361208] [034/171] (902s left) gem_linear_blits (basic) [98.456327] Starting subtest: basic [98.479234] Subtest basic: SUCCESS (0.023s) [98.597076] [035/171] (902s left) gem_mmap (basic) [98.676073] Subtest basic: SKIP (0.000s) [98.694333] [036/171] (902s left) gem_mmap_gtt (basic) [98.737443] Subtest basic: SKIP (0.000s) [98.760884] [037/171] (902s left) gem_render_linear_blits (basic) [98.804192] Starting subtest: basic [98.854761] Subtest basic: SUCCESS (0.051s) [98.911590] [038/171] (902s left) gem_render_tiled_blits (basic) [98.956069] Subtest basic: SKIP (0.000s) [98.978653] [039/171] (902s left) gem_ringfill (basic-all) [99.353833] Starting subtest: basic-all [100.746454] Subtest basic-all: SUCCESS (1.384s) [100.856880] [040/171] (900s left) gem_softpin (allocator-basic) [100.916598] Starting subtest: allocator-basic [101.044191] Subtest allocator-basic: SUCCESS (0.128s) [101.154732] [041/171] (900s left) gem_softpin (allocator-basic-reserve) [101.214110] Starting subtest: allocator-basic-reserve [101.345502] Subtest allocator-basic-reserve: SUCCESS (0.131s) [101.455531] [042/171] (899s left) gem_softpin (safe-alignment) [101.518773] Starting subtest: safe-alignment [101.560428] Subtest safe-alignment: SUCCESS (0.042s) [101.671264] [043/171] (899s left) gem_sync (basic-all) [101.737389] Starting subtest: basic-all [104.613293] Subtest basic-all: SUCCESS (2.875s) [104.795035] [044/171] (896s left) gem_sync (basic-each) [104.850130] Starting subtest: basic-each [107.175803] Subtest basic-each: SUCCESS (2.329s) [107.344364] [045/171] (894s left) gem_tiled_blits (basic) [107.389856] Subtest basic: SKIP (0.000s) [107.411233] [046/171] (893s left) gem_tiled_fence_blits (basic) [107.457591] Subtest basic: SKIP (0.000s) [107.478080] [047/171] (893s left) gem_tiled_pread_basic [107.544745] [048/171] (893s left) gem_wait (busy@all-engines) [107.592860] Starting subtest: busy [107.593744] Starting dynamic subtest: all-engines [108.155826] Dynamic subtest all-engines: SUCCESS (0.563s) [108.157066] Subtest busy: SUCCESS (0.563s) [108.377670] [049/171] (893s left) gem_wait (wait@all-engines) [108.428939] Starting subtest: wait [108.429799] Starting dynamic subtest: all-engines [109.511383] Dynamic subtest all-engines: SUCCESS (1.082s) [109.513140] Subtest wait: SUCCESS (1.082s) [109.728332] [050/171] (891s left) i915_getparams_basic (basic-eu-total) [109.775107] Starting subtest: basic-eu-total [109.776720] Subtest basic-eu-total: SUCCESS (0.000s) [109.842638] [051/171] (891s left) i915_getparams_basic (basic-subslice-total) [109.886042] Starting subtest: basic-subslice-total [109.887788] Subtest basic-subslice-total: SUCCESS (0.000s) [109.940329] [052/171] (891s left) i915_hangman (error-state-basic) [109.990424] Starting subtest: error-state-basic [110.244287] Subtest error-state-basic: SUCCESS (0.254s) [110.310336] [053/171] (891s left) i915_pciid [110.407458] [054/171] (891s left) kms_addfb_basic (addfb25-bad-modifier) [110.452118] Starting subtest: addfb25-bad-modifier [110.453083] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [110.557337] [055/171] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [110.604108] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [110.728958] [056/171] (890s left) kms_addfb_basic (addfb25-modifier-no-flag) [110.774292] Starting subtest: addfb25-modifier-no-flag [110.775168] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [110.877671] [057/171] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy) [110.921788] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [111.044542] [058/171] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [111.089874] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [111.211016] [059/171] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [111.290357] Starting subtest: addfb25-yf-tiled-legacy [111.291400] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [111.375257] [060/171] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy) [111.454625] Starting subtest: addfb25-y-tiled-legacy [111.455601] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [111.523352] [061/171] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [111.600959] Starting subtest: addfb25-y-tiled-small-legacy [111.603172] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [111.695623] [062/171] (889s left) kms_addfb_basic (bad-pitch-0) [111.740160] Starting subtest: bad-pitch-0 [111.741095] Subtest bad-pitch-0: SUCCESS (0.000s) [111.859656] [063/171] (889s left) kms_addfb_basic (bad-pitch-1024) [111.903220] Starting subtest: bad-pitch-1024 [111.904149] Subtest bad-pitch-1024: SUCCESS (0.000s) [112.006176] [064/171] (889s left) kms_addfb_basic (bad-pitch-128) [112.048922] Starting subtest: bad-pitch-128 [112.049761] Subtest bad-pitch-128: SUCCESS (0.000s) [112.156707] [065/171] (889s left) kms_addfb_basic (bad-pitch-256) [112.197889] Starting subtest: bad-pitch-256 [112.198876] Subtest bad-pitch-256: SUCCESS (0.000s) [112.308523] [066/171] (889s left) kms_addfb_basic (bad-pitch-32) [112.353117] Starting subtest: bad-pitch-32 [112.354110] Subtest bad-pitch-32: SUCCESS (0.000s) [112.459524] [067/171] (889s left) kms_addfb_basic (bad-pitch-63) [112.504206] Starting subtest: bad-pitch-63 [112.505112] Subtest bad-pitch-63: SUCCESS (0.000s) [112.607354] [068/171] (888s left) kms_addfb_basic (bad-pitch-65536) [112.650074] Starting subtest: bad-pitch-65536 [112.650950] Subtest bad-pitch-65536: SUCCESS (0.000s) [112.759536] [069/171] (888s left) kms_addfb_basic (bad-pitch-999) [112.803982] Starting subtest: bad-pitch-999 [112.804828] Subtest bad-pitch-999: SUCCESS (0.000s) [112.907893] [070/171] (888s left) kms_addfb_basic (basic) [112.951481] Starting subtest: basic [112.952579] Subtest basic: SUCCESS (0.000s) [113.075736] [071/171] (888s left) kms_addfb_basic (basic-x-tiled-legacy) [113.119906] Starting subtest: basic-x-tiled-legacy [113.121482] Subtest basic-x-tiled-legacy: SKIP (0.000s) [113.222652] [072/171] (888s left) kms_addfb_basic (basic-y-tiled-legacy) [113.268354] Starting subtest: basic-y-tiled-legacy [113.270213] Subtest basic-y-tiled-legacy: SKIP (0.000s) [113.372967] [073/171] (888s left) kms_addfb_basic (bo-too-small) [113.451219] Starting subtest: bo-too-small [113.452271] Subtest bo-too-small: SUCCESS (0.000s) [113.523312] [074/171] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.603076] Starting subtest: bo-too-small-due-to-tiling [113.605046] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [113.673201] [075/171] (887s left) kms_addfb_basic (clobberred-modifier) [113.714976] Starting subtest: clobberred-modifier [113.716681] Subtest clobberred-modifier: SKIP (0.000s) [113.824229] [076/171] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.869830] Starting subtest: framebuffer-vs-set-tiling [113.871832] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [113.973178] [077/171] (887s left) kms_addfb_basic (invalid-get-prop) [114.015838] Starting subtest: invalid-get-prop [114.016580] Subtest invalid-get-prop: SUCCESS (0.000s) [114.122208] [078/171] (887s left) kms_addfb_basic (invalid-get-prop-any) [114.165194] Starting subtest: invalid-get-prop-any [114.166060] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.276234] [079/171] (887s left) kms_addfb_basic (invalid-set-prop) [114.319970] Starting subtest: invalid-set-prop [114.320816] Subtest invalid-set-prop: SUCCESS (0.000s) [114.422959] [080/171] (887s left) kms_addfb_basic (invalid-set-prop-any) [114.465952] Starting subtest: invalid-set-prop-any [114.466814] Subtest invalid-set-prop-any: SUCCESS (0.000s) [114.574552] [081/171] (887s left) kms_addfb_basic (no-handle) [114.618328] Starting subtest: no-handle [114.619071] Subtest no-handle: SUCCESS (0.000s) [114.725339] [082/171] (886s left) kms_addfb_basic (size-max) [114.804211] Starting subtest: size-max [114.804971] Subtest size-max: SUCCESS (0.000s) [114.876074] [083/171] (886s left) kms_addfb_basic (small-bo) [114.955953] Starting subtest: small-bo [114.956698] Subtest small-bo: SUCCESS (0.000s) [115.024135] [084/171] (886s left) kms_addfb_basic (tile-pitch-mismatch) [115.067974] Starting subtest: tile-pitch-mismatch [115.069790] Subtest tile-pitch-mismatch: SKIP (0.000s) [115.174571] [085/171] (886s left) kms_addfb_basic (too-high) [115.253360] Starting subtest: too-high [115.254149] Subtest too-high: SUCCESS (0.000s) [115.322840] [086/171] (886s left) kms_addfb_basic (too-wide) [115.400414] Starting subtest: too-wide [115.401250] Subtest too-wide: SUCCESS (0.000s) [115.474109] [087/171] (886s left) kms_addfb_basic (unused-handle) [115.517976] Starting subtest: unused-handle [115.518829] Subtest unused-handle: SUCCESS (0.000s) [115.625463] [088/171] (886s left) kms_addfb_basic (unused-modifier) [115.669133] Starting subtest: unused-modifier [115.670121] Subtest unused-modifier: SUCCESS (0.000s) [115.794402] [089/171] (885s left) kms_addfb_basic (unused-offsets) [115.838126] Starting subtest: unused-offsets [115.838984] Subtest unused-offsets: SUCCESS (0.000s) [115.960554] [090/171] (885s left) kms_addfb_basic (unused-pitches) [116.005100] Starting subtest: unused-pitches [116.005931] Subtest unused-pitches: SUCCESS (0.000s) [116.127604] [091/171] (885s left) kms_busy (basic) [116.213137] Starting subtest: basic [116.214118] Starting dynamic subtest: flip [116.923109] Dynamic subtest flip: SUCCESS (0.708s) [116.927588] Starting dynamic subtest: modeset [117.621694] Dynamic subtest modeset: SUCCESS (0.696s) [117.622708] Subtest basic: SUCCESS (1.405s) [117.737056] [092/171] (884s left) kms_chamelium_hpd (dp-hpd-fast) [117.893631] Subtest dp-hpd-fast: SKIP (0.000s) [117.963171] [093/171] (883s left) kms_chamelium_edid (dp-edid-read) [118.111406] Subtest dp-edid-read: SKIP (0.000s) [118.179843] [094/171] (883s left) kms_chamelium_frames (dp-crc-fast) [118.329913] Subtest dp-crc-fast: SKIP (0.000s) [118.399021] [095/171] (883s left) kms_chamelium_hpd (hdmi-hpd-fast) [118.545069] Subtest hdmi-hpd-fast: SKIP (0.000s) [118.615220] [096/171] (883s left) kms_chamelium_edid (hdmi-edid-read) [118.763479] Subtest hdmi-edid-read: SKIP (0.000s) [118.832655] [097/171] (883s left) kms_chamelium_frames (hdmi-crc-fast) [118.980635] Subtest hdmi-crc-fast: SKIP (0.000s) [119.048855] [098/171] (882s left) kms_chamelium_hpd (vga-hpd-fast) [119.196993] Subtest vga-hpd-fast: SKIP (0.000s) [119.266986] [099/171] (882s left) kms_chamelium_edid (vga-edid-read) [119.414406] Subtest vga-edid-read: SKIP (0.000s) [119.484014] [100/171] (882s left) kms_prop_blob (basic) [119.527452] Starting subtest: basic [119.529008] Subtest basic: SUCCESS (0.000s) [119.593125] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [119.670136] Starting subtest: basic-busy-flip-before-cursor-atomic [119.672094] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [119.726225] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [119.804464] Starting subtest: basic-busy-flip-before-cursor-legacy [119.806154] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [119.859495] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [119.937378] Starting subtest: basic-flip-after-cursor-atomic [120.963877] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.026s) [121.112617] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [121.190082] Starting subtest: basic-flip-after-cursor-legacy [122.199642] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.011s) [122.349807] [105/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [122.429889] Starting subtest: basic-flip-after-cursor-varying-size [123.469106] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.039s) [123.619695] [106/171] (878s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [123.697305] Starting subtest: basic-flip-before-cursor-atomic [124.722033] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.024s) [124.866742] [107/171] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [124.943651] Starting subtest: basic-flip-before-cursor-legacy [125.955013] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.010s) [126.093282] [108/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [126.170754] Starting subtest: basic-flip-before-cursor-varying-size [127.195856] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.026s) [127.342164] [109/171] (874s left) kms_flip (basic-flip-vs-dpms) [127.412965] Starting subtest: basic-flip-vs-dpms [127.415467] Starting dynamic subtest: A-HDMI-A3 [128.232579] Dynamic subtest A-HDMI-A3: SUCCESS (0.816s) [128.236801] Starting dynamic subtest: B-HDMI-A3 [128.985318] Dynamic subtest B-HDMI-A3: SUCCESS (0.753s) [128.989809] Starting dynamic subtest: C-HDMI-A3 [129.747151] Dynamic subtest C-HDMI-A3: SUCCESS (0.757s) [129.751925] Starting dynamic subtest: D-HDMI-A3 [130.507703] Dynamic subtest D-HDMI-A3: SUCCESS (0.764s) [130.508631] Subtest basic-flip-vs-dpms: SUCCESS (3.096s) [130.652167] [110/171] (871s left) kms_flip (basic-flip-vs-modeset) [130.724652] Starting subtest: basic-flip-vs-modeset [130.726445] Starting dynamic subtest: A-HDMI-A3 [131.531522] Dynamic subtest A-HDMI-A3: SUCCESS (0.805s) [131.536132] Starting dynamic subtest: B-HDMI-A3 [132.309468] Dynamic subtest B-HDMI-A3: SUCCESS (0.777s) [132.314333] Starting dynamic subtest: C-HDMI-A3 [133.068769] Dynamic subtest C-HDMI-A3: SUCCESS (0.759s) [133.073228] Starting dynamic subtest: D-HDMI-A3 [133.836285] Dynamic subtest D-HDMI-A3: SUCCESS (0.768s) [133.837305] Subtest basic-flip-vs-modeset: SUCCESS (3.115s) [133.978318] [111/171] (868s left) kms_flip (basic-flip-vs-wf_vblank) [134.052880] Starting subtest: basic-flip-vs-wf_vblank [134.054937] Starting dynamic subtest: A-HDMI-A3 [135.152794] Dynamic subtest A-HDMI-A3: SUCCESS (1.097s) [135.163279] Starting dynamic subtest: B-HDMI-A3 [136.196140] Dynamic subtest B-HDMI-A3: SUCCESS (1.042s) [136.202122] Starting dynamic subtest: C-HDMI-A3 [137.222306] Dynamic subtest C-HDMI-A3: SUCCESS (1.025s) [137.228277] Starting dynamic subtest: D-HDMI-A3 [138.248620] Dynamic subtest D-HDMI-A3: SUCCESS (1.026s) [138.250939] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.200s) [138.462811] [112/171] (863s left) kms_flip (basic-plain-flip) [138.536971] Starting subtest: basic-plain-flip [138.537969] Starting dynamic subtest: A-HDMI-A3 [139.352803] Dynamic subtest A-HDMI-A3: SUCCESS (0.814s) [139.359057] Starting dynamic subtest: B-HDMI-A3 [140.114210] Dynamic subtest B-HDMI-A3: SUCCESS (0.761s) [140.120218] Starting dynamic subtest: C-HDMI-A3 [140.873781] Dynamic subtest C-HDMI-A3: SUCCESS (0.758s) [140.880978] Starting dynamic subtest: D-HDMI-A3 [141.615452] Dynamic subtest D-HDMI-A3: SUCCESS (0.742s) [141.617932] Subtest basic-plain-flip: SUCCESS (3.084s) [141.808359] [113/171] (860s left) kms_force_connector_basic (force-connector-state) [141.906943] Starting subtest: force-connector-state [142.333195] Subtest force-connector-state: SUCCESS (0.427s) [142.585311] [114/171] (859s left) kms_force_connector_basic (force-edid) [142.682357] Starting subtest: force-edid [142.694933] Subtest force-edid: SUCCESS (0.013s) [142.868184] [115/171] (859s left) kms_force_connector_basic (force-load-detect) [142.965547] Starting subtest: force-load-detect [142.967051] Subtest force-load-detect: SKIP (0.000s) [143.135014] [116/171] (858s left) kms_force_connector_basic (prune-stale-modes) [143.233643] Starting subtest: prune-stale-modes [143.240680] Subtest prune-stale-modes: SKIP (0.007s) [143.401479] [117/171] (858s left) kms_frontbuffer_tracking (basic) [143.486167] Starting subtest: basic [146.685390] Subtest basic: SUCCESS (3.201s) [146.791833] [118/171] (855s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [146.873611] Starting subtest: compare-crc-sanitycheck [146.874537] Starting dynamic subtest: pipe-A-HDMI-A-3 [147.354923] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.481s) [147.360826] Starting dynamic subtest: pipe-B-HDMI-A-3 [147.815234] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.458s) [147.821184] Starting dynamic subtest: pipe-C-HDMI-A-3 [148.327757] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.512s) [148.332343] Starting dynamic subtest: pipe-D-HDMI-A-3 [148.874062] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.545s) [148.875084] Subtest compare-crc-sanitycheck: SUCCESS (2.000s) [149.012941] [119/171] (853s left) kms_pipe_crc_basic (hang-read-crc) [149.092205] Starting subtest: hang-read-crc [149.093055] Starting dynamic subtest: pipe-A-HDMI-A-3 [150.736454] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.645s) [150.740990] Starting dynamic subtest: pipe-B-HDMI-A-3 [152.345552] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.607s) [152.350147] Starting dynamic subtest: pipe-C-HDMI-A-3 [154.082116] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.736s) [154.086803] Starting dynamic subtest: pipe-D-HDMI-A-3 [155.881829] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.799s) [155.882906] Subtest hang-read-crc: SUCCESS (6.791s) [156.045479] [120/171] (846s left) kms_pipe_crc_basic (nonblocking-crc) [156.124728] Starting subtest: nonblocking-crc [156.126931] Starting dynamic subtest: pipe-A-HDMI-A-3 [156.816595] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.690s) [156.821065] Starting dynamic subtest: pipe-B-HDMI-A-3 [157.442296] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.625s) [157.446600] Starting dynamic subtest: pipe-C-HDMI-A-3 [158.118730] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.675s) [158.123219] Starting dynamic subtest: pipe-D-HDMI-A-3 [158.829634] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.710s) [158.830464] Subtest nonblocking-crc: SUCCESS (2.705s) [158.966741] [121/171] (843s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [159.043747] Starting subtest: nonblocking-crc-frame-sequence [159.044594] Starting dynamic subtest: pipe-A-HDMI-A-3 [159.701504] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.658s) [159.705959] Starting dynamic subtest: pipe-B-HDMI-A-3 [160.331614] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.629s) [160.336233] Starting dynamic subtest: pipe-C-HDMI-A-3 [161.007831] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.669s) [161.021010] Starting dynamic subtest: pipe-D-HDMI-A-3 [161.714305] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.712s) [161.715054] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.671s) [161.853856] [122/171] (840s left) kms_pipe_crc_basic (read-crc) [161.929378] Starting subtest: read-crc [161.930139] Starting dynamic subtest: pipe-A-HDMI-A-3 [162.525878] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.594s) [162.530686] Starting dynamic subtest: pipe-B-HDMI-A-3 [163.080296] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.554s) [163.084933] Starting dynamic subtest: pipe-C-HDMI-A-3 [163.683169] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.603s) [163.687675] Starting dynamic subtest: pipe-D-HDMI-A-3 [164.339529] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.655s) [164.340488] Subtest read-crc: SUCCESS (2.409s) [164.473472] [123/171] (837s left) kms_pipe_crc_basic (read-crc-frame-sequence) [164.554106] Starting subtest: read-crc-frame-sequence [164.555114] Starting dynamic subtest: pipe-A-HDMI-A-3 [165.175255] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.621s) [165.180223] Starting dynamic subtest: pipe-B-HDMI-A-3 [165.746029] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.570s) [165.751265] Starting dynamic subtest: pipe-C-HDMI-A-3 [166.377192] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.630s) [166.382175] Starting dynamic subtest: pipe-D-HDMI-A-3 [167.052347] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.675s) [167.053087] Subtest read-crc-frame-sequence: SUCCESS (2.499s) [167.188235] [124/171] (834s left) kms_psr (primary_page_flip) [167.231198] Subtest primary_page_flip: SKIP (0.000s) [167.260408] [125/171] (834s left) kms_psr (cursor_plane_move) [167.305027] Subtest cursor_plane_move: SKIP (0.000s) [167.327152] [126/171] (834s left) kms_psr (sprite_plane_onoff) [167.372013] Subtest sprite_plane_onoff: SKIP (0.000s) [167.392304] [127/171] (834s left) kms_psr (primary_mmap_gtt) [167.439475] Subtest primary_mmap_gtt: SKIP (0.000s) [167.459273] [128/171] (834s left) kms_setmode (basic-clone-single-crtc) [167.502060] Starting subtest: basic-clone-single-crtc [167.504543] Subtest basic-clone-single-crtc: SKIP (0.000s) [167.557467] [129/171] (834s left) i915_pm_backlight (basic-brightness) [167.636246] Subtest basic-brightness: SKIP (0.000s) [167.659949] [130/171] (834s left) i915_pm_rpm (basic-pci-d3-state) [169.919106] Starting subtest: basic-pci-d3-state [171.276437] Subtest basic-pci-d3-state: SUCCESS (1.359s) [171.396504] [131/171] (830s left) i915_pm_rpm (basic-rte) [171.430098] Starting subtest: basic-rte [173.459189] Subtest basic-rte: SUCCESS (2.029s) [174.036100] [132/171] (828s left) i915_pm_rps (basic-api) [174.081187] Starting subtest: basic-api [174.083132] Subtest basic-api: SKIP (0.000s) [174.138492] [133/171] (828s left) prime_self_import (basic-llseek-bad) [174.173193] Starting subtest: basic-llseek-bad [174.184969] Subtest basic-llseek-bad: SUCCESS (0.011s) [174.255705] [134/171] (827s left) prime_self_import (basic-llseek-size) [174.290485] Starting subtest: basic-llseek-size [174.302289] Subtest basic-llseek-size: SUCCESS (0.012s) [174.371525] [135/171] (827s left) prime_self_import (basic-with_fd_dup) [174.405278] Starting subtest: basic-with_fd_dup [174.418100] Subtest basic-with_fd_dup: SUCCESS (0.012s) [174.488640] [136/171] (827s left) prime_self_import (basic-with_one_bo) [174.522054] Starting subtest: basic-with_one_bo [174.534934] Subtest basic-with_one_bo: SUCCESS (0.012s) [174.591400] [137/171] (827s left) prime_self_import (basic-with_one_bo_two_files) [174.623434] Starting subtest: basic-with_one_bo_two_files [174.635602] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s) [174.704521] [138/171] (827s left) prime_self_import (basic-with_two_bos) [174.736832] Starting subtest: basic-with_two_bos [174.749066] Subtest basic-with_two_bos: SUCCESS (0.012s) [174.821522] [139/171] (827s left) prime_vgem (basic-fence-flip) [174.882295] Starting subtest: basic-fence-flip [174.940362] Subtest basic-fence-flip: SKIP (0.057s) [175.019446] [140/171] (827s left) prime_vgem (basic-fence-mmap) [175.084015] Starting subtest: basic-fence-mmap [175.086253] Subtest basic-fence-mmap: SKIP (0.000s) [175.173890] [141/171] (827s left) prime_vgem (basic-fence-read) [175.233030] Starting subtest: basic-fence-read [175.237047] Subtest basic-fence-read: SKIP (0.004s) [175.324706] [142/171] (826s left) prime_vgem (basic-gtt) [175.383205] Starting subtest: basic-gtt [175.385143] Subtest basic-gtt: SKIP (0.000s) [175.476194] [143/171] (826s left) prime_vgem (basic-read) [175.543020] Starting subtest: basic-read [175.546219] Subtest basic-read: SKIP (0.003s) [175.640565] [144/171] (826s left) prime_vgem (basic-write) [175.707973] Starting subtest: basic-write [175.711266] Subtest basic-write: SKIP (0.003s) [175.803850] [145/171] (826s left) prime_vgem (basic-userptr) [175.864627] Starting subtest: basic-userptr [175.869459] Subtest basic-userptr: SKIP (0.004s) [175.958730] [146/171] (826s left) vgem_basic (setversion) [176.002241] Starting subtest: setversion [176.005237] Subtest setversion: SUCCESS (0.000s) [176.054666] [147/171] (826s left) vgem_basic (create) [176.102077] Starting subtest: create [176.103149] Subtest create: SUCCESS (0.000s) [176.153457] [148/171] (826s left) vgem_basic (debugfs) [176.202091] Starting subtest: debugfs [176.203126] Subtest debugfs: SUCCESS (0.000s) [176.255033] [149/171] (826s left) vgem_basic (dmabuf-export) [176.302086] Starting subtest: dmabuf-export [176.313172] Subtest dmabuf-export: SUCCESS (0.011s) [176.387773] [150/171] (825s left) vgem_basic (dmabuf-fence) [176.434930] Starting subtest: dmabuf-fence [176.435677] Subtest dmabuf-fence: SUCCESS (0.000s) [176.489422] [151/171] (825s left) vgem_basic (dmabuf-fence-before) [176.535234] Starting subtest: dmabuf-fence-before [176.536493] Subtest dmabuf-fence-before: SUCCESS (0.000s) [176.586899] [152/171] (825s left) vgem_basic (dmabuf-mmap) [176.635335] Starting subtest: dmabuf-mmap [176.641740] Subtest dmabuf-mmap: SUCCESS (0.006s) [176.688202] [153/171] (825s left) vgem_basic (mmap) [176.735525] Starting subtest: mmap [176.739652] Subtest mmap: SUCCESS (0.004s) [176.788692] [154/171] (825s left) vgem_basic (second-client) [176.835270] Starting subtest: second-client [176.886339] Subtest second-client: SUCCESS (0.050s) [176.946203] [155/171] (825s left) vgem_basic (sysfs) [176.985099] Starting subtest: sysfs [176.985955] Subtest sysfs: SUCCESS (0.000s) [177.040730] [156/171] (825s left) core_hotunplug (unbind-rebind) [177.119167] Starting subtest: unbind-rebind [178.403499] Subtest unbind-rebind: SUCCESS (1.284s) [178.414508] [157/171] (824s left) vgem_basic (unload) [178.447725] Starting subtest: unload [207.231712] Subtest unload: SUCCESS (28.774s) [207.324152] [158/171] (795s left) i915_module_load (reload) [207.356691] Starting subtest: reload [212.491662] Subtest reload: SUCCESS (5.135s) [212.501339] [159/171] (789s left) gem_lmem_swapping (basic) [219.182197] Starting subtest: basic [219.183167] Starting dynamic subtest: lmem0 [234.869993] Dynamic subtest lmem0: SUCCESS (15.677s) [234.871091] Subtest basic: SUCCESS (15.678s) [236.364872] [160/171] (766s left) gem_lmem_swapping (parallel-random-engines) [240.113982] Starting subtest: parallel-random-engines [240.114738] Starting dynamic subtest: lmem0 [240.871146] Dynamic subtest lmem0: SUCCESS (0.757s) [240.871931] Subtest parallel-random-engines: SUCCESS (0.757s) [244.221114] [161/171] (758s left) gem_lmem_swapping (random-engines) [248.096068] Starting subtest: random-engines [248.096862] Starting dynamic subtest: lmem0 [248.631984] Dynamic subtest lmem0: SUCCESS (0.536s) [248.632737] Subtest random-engines: SUCCESS (0.536s) [252.964615] [162/171] (749s left) gem_lmem_swapping (verify-random) [257.152277] Starting subtest: verify-random [257.153163] Starting dynamic subtest: lmem0 [264.822693] Dynamic subtest lmem0: SUCCESS (7.670s) [264.823406] Subtest verify-random: SUCCESS (7.671s) [266.741870] [163/171] (735s left) i915_pm_rpm (module-reload) [274.302044] Starting subtest: module-reload [290.531300] Subtest module-reload: SUCCESS (16.219s) [290.542470] [164/171] (712s left) i915_selftest (live) [290.581708] Starting subtest: live [290.582535] Starting dynamic subtest: sanitycheck [292.626757] Dynamic subtest sanitycheck: SUCCESS (2.035s) [292.631255] Starting dynamic subtest: uncore [294.716148] Dynamic subtest uncore: SUCCESS (2.089s) [294.720594] Starting dynamic subtest: workarounds [302.847300] Dynamic subtest workarounds: SUCCESS (8.131s) [302.853652] Starting dynamic subtest: gt_engines [306.189259] Dynamic subtest gt_engines: SUCCESS (3.351s) [306.194800] Starting dynamic subtest: gt_timelines [331.000661] Dynamic subtest gt_timelines: SUCCESS (24.802s) [331.006776] Starting dynamic subtest: gt_contexts [333.145200] Dynamic subtest gt_contexts: SUCCESS (2.144s) [333.149352] Starting dynamic subtest: gt_lrc [342.862375] Dynamic subtest gt_lrc: SUCCESS (9.717s) [342.868361] Starting dynamic subtest: gt_mocs [348.118043] Dynamic subtest gt_mocs: SUCCESS (5.258s) [348.123745] Starting dynamic subtest: gt_pm [352.005472] Dynamic subtest gt_pm: SUCCESS (3.891s) [352.009259] Starting dynamic subtest: gt_heartbeat [354.366840] Dynamic subtest gt_heartbeat: SUCCESS (2.357s) [354.378391] Starting dynamic subtest: requests [376.983303] Dynamic subtest requests: SUCCESS (22.616s) [376.987810] Starting dynamic subtest: migrate [385.581135] Dynamic subtest migrate: SUCCESS (8.598s) [385.584697] Starting dynamic subtest: active [387.607516] Dynamic subtest active: SUCCESS (2.026s) [387.611477] Starting dynamic subtest: objects [390.754252] Dynamic subtest objects: SUCCESS (3.148s) [390.760118] Starting dynamic subtest: mman [404.012505] Dynamic subtest mman: SUCCESS (13.261s) [404.017935] Starting dynamic subtest: dmabuf [406.254656] Dynamic subtest dmabuf: SUCCESS (2.239s) [406.259120] Starting dynamic subtest: vma [408.539135] Dynamic subtest vma: SUCCESS (2.284s) [408.543508] Starting dynamic subtest: coherency [417.239516] Dynamic subtest coherency: SUCCESS (8.701s) [417.243213] Starting dynamic subtest: gtt [440.544235] Dynamic subtest gtt: SUCCESS (23.304s) [440.550325] Starting dynamic subtest: gem [443.004367] Dynamic subtest gem: SUCCESS (2.460s) [443.008341] Starting dynamic subtest: evict [448.944100] Dynamic subtest evict: SUCCESS (5.941s) [448.948235] Starting dynamic subtest: hugepages [472.541838] Dynamic subtest hugepages: SUCCESS (23.597s) [472.546702] Starting dynamic subtest: gem_contexts [518.265308] Dynamic subtest gem_contexts: SUCCESS (45.723s) [518.269636] Starting dynamic subtest: client [520.443769] Dynamic subtest client: SUCCESS (2.178s) [520.447805] Starting dynamic subtest: gem_migrate [528.990303] Dynamic subtest gem_migrate: SUCCESS (8.546s) [528.994203] Starting dynamic subtest: reset [535.339285] Dynamic subtest reset: SUCCESS (6.348s) [535.343440] Starting dynamic subtest: memory_region [538.997138] Dynamic subtest memory_region: SUCCESS (3.657s) [539.001392] Starting dynamic subtest: hangcheck [590.363496] Warning: kernel log ringbuffer underflow, some records lost. [593.209532] Disk usage limit exceeded. [608.318495] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [608.319494] Closing watchdogs Done.