[44.828362] Initializing watchdogs [44.828501] /dev/watchdog0 [44.838292] [001/165] (960s left) i915_module_load (load) [44.937940] Starting subtest: load [47.520014] Subtest load: SUCCESS (2.582s) [47.544231] [002/165] (957s left) core_auth (basic-auth) [47.647854] Starting subtest: basic-auth [47.649151] Subtest basic-auth: SUCCESS (0.001s) [47.722337] [003/165] (957s left) debugfs_test (read_all_entries) [47.821537] Starting subtest: read_all_entries [47.943543] Subtest read_all_entries: SUCCESS (0.121s) [48.061831] [004/165] (957s left) debugfs_test (basic-hwmon) [48.155973] Starting subtest: basic-hwmon [48.158419] Subtest basic-hwmon: SKIP (0.000s) [48.288141] [005/165] (957s left) fbdev (eof) [48.395708] Starting subtest: eof [48.397609] Subtest eof: SUCCESS (0.002s) [48.467562] [006/165] (957s left) fbdev (info) [48.569761] Starting subtest: info [48.571044] Subtest info: SUCCESS (0.000s) [48.691703] [007/165] (956s left) fbdev (nullptr) [48.788795] Starting subtest: nullptr [48.790037] Subtest nullptr: SUCCESS (0.000s) [48.862640] [008/165] (956s left) fbdev (read) [48.955922] Starting subtest: read [56.037627] Subtest read: SUCCESS (7.046s) [56.084738] [009/165] (949s left) fbdev (write) [56.180265] Starting subtest: write [59.954171] Subtest write: SUCCESS (3.739s) [60.007643] [010/165] (945s left) gem_basic (bad-close) [60.098361] Starting subtest: bad-close [60.100861] Subtest bad-close: SUCCESS (0.000s) [60.194676] [011/165] (945s left) gem_basic (create-close) [60.283362] Starting subtest: create-close [60.285631] Subtest create-close: SUCCESS (0.000s) [60.377955] [012/165] (945s left) gem_basic (create-fd-close) [60.466611] Starting subtest: create-fd-close [60.468692] Subtest create-fd-close: SUCCESS (0.000s) [60.560302] [013/165] (945s left) gem_busy (busy@all-engines) [60.670044] Starting subtest: busy [60.671280] Starting dynamic subtest: all-engines [60.729760] Dynamic subtest all-engines: SUCCESS (0.060s) [60.730908] Subtest busy: SUCCESS (0.060s) [61.108106] [014/165] (944s left) gem_close_race (basic-process) [61.236968] Starting subtest: basic-process [61.301667] Subtest basic-process: SUCCESS (0.067s) [61.491380] [015/165] (944s left) gem_close_race (basic-threads) [61.612594] Starting subtest: basic-threads [62.782755] Subtest basic-threads: SUCCESS (1.172s) [63.029928] [016/165] (942s left) gem_ctx_create (basic) [63.136192] Starting subtest: basic [63.137384] Subtest basic: SUCCESS (0.000s) [63.350848] [017/165] (942s left) gem_ctx_create (basic-files) [63.454147] Starting subtest: basic-files [65.481349] Subtest basic-files: SUCCESS (2.027s) [65.729592] [018/165] (940s left) gem_ctx_exec (basic) [65.824215] Starting subtest: basic [65.828902] Subtest basic: SUCCESS (0.005s) [65.951583] [019/165] (939s left) gem_exec_basic (basic) [66.054378] Starting subtest: basic [66.055661] Starting dynamic subtest: rcs0-smem [66.057073] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [66.074475] Starting dynamic subtest: bcs0-smem [66.075982] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [66.092586] Starting dynamic subtest: vcs0-smem [66.093928] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [66.110560] Starting dynamic subtest: vecs0-smem [66.112025] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [66.113338] Subtest basic: SUCCESS (0.005s) [66.268979] [020/165] (939s left) gem_exec_create (basic) [66.373686] Starting subtest: basic [66.374881] Starting dynamic subtest: smem [68.444268] Dynamic subtest smem: SUCCESS (2.047s) [68.446224] Subtest basic: SUCCESS (2.048s) [68.670283] [021/165] (937s left) gem_exec_fence (basic-busy) [68.924436] Starting subtest: basic-busy [68.925854] Starting dynamic subtest: rcs0 [68.958205] Dynamic subtest rcs0: SUCCESS (0.042s) [68.980655] Starting dynamic subtest: bcs0 [68.991840] Dynamic subtest bcs0: SUCCESS (0.033s) [69.012079] Starting dynamic subtest: vcs0 [69.021545] Dynamic subtest vcs0: SUCCESS (0.030s) [69.039342] Starting dynamic subtest: vecs0 [69.044453] Dynamic subtest vecs0: SUCCESS (0.023s) [69.045628] Subtest basic-busy: SUCCESS (0.129s) [69.660156] [022/165] (936s left) gem_exec_fence (basic-wait) [69.911468] Starting subtest: basic-wait [69.912843] Starting dynamic subtest: rcs0 [69.930575] Dynamic subtest rcs0: SUCCESS (0.028s) [69.950071] Starting dynamic subtest: bcs0 [69.958413] Dynamic subtest bcs0: SUCCESS (0.028s) [69.977304] Starting dynamic subtest: vcs0 [69.983452] Dynamic subtest vcs0: SUCCESS (0.025s) [70.002242] Starting dynamic subtest: vecs0 [70.007993] Dynamic subtest vecs0: SUCCESS (0.024s) [70.009142] Subtest basic-wait: SUCCESS (0.105s) [70.558463] [023/165] (935s left) gem_exec_fence (basic-await) [70.813473] Starting subtest: basic-await [70.814624] Starting dynamic subtest: rcs0 [70.905895] Dynamic subtest rcs0: SUCCESS (0.100s) [70.936183] Starting dynamic subtest: bcs0 [71.017704] Dynamic subtest bcs0: SUCCESS (0.110s) [71.059879] Starting dynamic subtest: vcs0 [71.148402] Dynamic subtest vcs0: SUCCESS (0.130s) [71.190820] Starting dynamic subtest: vecs0 [71.279584] Dynamic subtest vecs0: SUCCESS (0.130s) [71.281813] Subtest basic-await: SUCCESS (0.474s) [71.858581] [024/165] (934s left) gem_exec_fence (nb-await) [72.107119] Starting subtest: nb-await [72.108229] Starting dynamic subtest: rcs0 [72.165442] Dynamic subtest rcs0: SUCCESS (0.065s) [72.186963] Starting dynamic subtest: bcs0 [72.231093] Dynamic subtest bcs0: SUCCESS (0.065s) [72.258334] Starting dynamic subtest: vcs0 [72.301816] Dynamic subtest vcs0: SUCCESS (0.070s) [72.335076] Starting dynamic subtest: vecs0 [72.374641] Dynamic subtest vecs0: SUCCESS (0.072s) [72.376789] Subtest nb-await: SUCCESS (0.275s) [72.927366] [025/165] (933s left) gem_exec_gttfill (basic) [73.035867] Starting subtest: basic [79.256830] Subtest basic: SUCCESS (6.212s) [79.446862] [026/165] (926s left) gem_exec_parallel (engines) [79.618353] Starting subtest: engines [79.621647] Starting dynamic subtest: basic [82.085809] Dynamic subtest basic: SUCCESS (2.455s) [82.106376] Starting dynamic subtest: contexts [87.479646] Dynamic subtest contexts: SUCCESS (5.399s) [87.500927] Starting dynamic subtest: fds [95.495611] Dynamic subtest fds: SUCCESS (8.024s) [95.523585] Starting dynamic subtest: userptr [98.014442] Dynamic subtest userptr: SUCCESS (2.504s) [98.016208] Subtest engines: SUCCESS (18.384s) [98.236308] [027/165] (907s left) gem_exec_store (basic) [98.342475] Starting subtest: basic [98.394079] Subtest basic: SUCCESS (0.051s) [98.605816] [028/165] (907s left) gem_flink_basic (bad-flink) [98.697651] Starting subtest: bad-flink [98.698856] Subtest bad-flink: SUCCESS (0.000s) [98.785981] [029/165] (907s left) gem_flink_basic (bad-open) [98.873973] Starting subtest: bad-open [98.875206] Subtest bad-open: SUCCESS (0.000s) [98.972066] [030/165] (907s left) gem_flink_basic (basic) [99.061798] Starting subtest: basic [99.062984] Subtest basic: SUCCESS (0.000s) [99.153314] [031/165] (907s left) gem_flink_basic (double-flink) [99.245760] Starting subtest: double-flink [99.247056] Subtest double-flink: SUCCESS (0.000s) [99.356812] [032/165] (907s left) gem_flink_basic (flink-lifetime) [99.445888] Starting subtest: flink-lifetime [99.448636] Subtest flink-lifetime: SUCCESS (0.002s) [99.557595] [033/165] (906s left) gem_huc_copy (huc-copy) [99.652546] Starting subtest: huc-copy [99.654921] Subtest huc-copy: SKIP (0.000s) [99.773196] [034/165] (906s left) gem_linear_blits (basic) [100.030561] Starting subtest: basic [100.041688] Subtest basic: SUCCESS (0.012s) [100.192804] [035/165] (906s left) gem_mmap (basic) [100.347734] Starting subtest: basic [100.352817] Subtest basic: SUCCESS (0.001s) [100.458627] [036/165] (906s left) gem_mmap_gtt (basic) [100.547556] Starting subtest: basic [100.548757] Subtest basic: SUCCESS (0.001s) [100.634260] [037/165] (905s left) gem_render_linear_blits (basic) [100.730176] Starting subtest: basic [100.778644] Subtest basic: SUCCESS (0.048s) [100.855521] [038/165] (905s left) gem_render_tiled_blits (basic) [100.950986] Starting subtest: basic [101.010568] Subtest basic: SUCCESS (0.059s) [101.086151] [039/165] (905s left) gem_ringfill (basic-all) [101.318524] Starting subtest: basic-all [102.534357] Subtest basic-all: SUCCESS (1.206s) [102.628018] [040/165] (904s left) gem_softpin (allocator-basic) [102.724816] Starting subtest: allocator-basic [102.891369] Subtest allocator-basic: SUCCESS (0.158s) [103.013841] [041/165] (903s left) gem_softpin (allocator-basic-reserve) [103.108961] Starting subtest: allocator-basic-reserve [103.275110] Subtest allocator-basic-reserve: SUCCESS (0.158s) [103.393258] [042/165] (903s left) gem_softpin (safe-alignment) [103.491136] Starting subtest: safe-alignment [103.508571] Subtest safe-alignment: SUCCESS (0.017s) [103.629882] [043/165] (903s left) gem_sync (basic-all) [103.737386] Starting subtest: basic-all [105.994055] Subtest basic-all: SUCCESS (2.234s) [106.181267] [044/165] (900s left) gem_sync (basic-each) [106.286415] Starting subtest: basic-each [108.481060] Subtest basic-each: SUCCESS (2.195s) [108.731816] [045/165] (898s left) gem_tiled_blits (basic) [108.970035] Starting subtest: basic [108.998999] Subtest basic: SUCCESS (0.029s) [109.136609] [046/165] (897s left) gem_tiled_fence_blits (basic) [109.450890] Starting subtest: basic [109.478432] Subtest basic: SUCCESS (0.027s) [109.631222] [047/165] (897s left) gem_tiled_pread_basic [110.151665] [048/165] (896s left) gem_wait (busy@all-engines) [110.268646] Starting subtest: busy [110.269826] Starting dynamic subtest: all-engines [110.795089] Dynamic subtest all-engines: SUCCESS (0.526s) [110.796279] Subtest busy: SUCCESS (0.526s) [111.053280] [049/165] (895s left) gem_wait (wait@all-engines) [111.166370] Starting subtest: wait [111.167502] Starting dynamic subtest: all-engines [112.201105] Dynamic subtest all-engines: SUCCESS (1.034s) [112.202900] Subtest wait: SUCCESS (1.035s) [112.453267] [050/165] (894s left) i915_getparams_basic (basic-eu-total) [112.544702] Starting subtest: basic-eu-total [112.547270] Subtest basic-eu-total: SUCCESS (0.000s) [112.635384] [051/165] (894s left) i915_getparams_basic (basic-subslice-total) [112.722514] Starting subtest: basic-subslice-total [112.724634] Subtest basic-subslice-total: SUCCESS (0.000s) [112.820545] [052/165] (894s left) i915_hangman (error-state-basic) [112.925463] Starting subtest: error-state-basic [112.941062] Subtest error-state-basic: SUCCESS (0.014s) [113.036951] [053/165] (894s left) i915_pciid [113.220859] [054/165] (893s left) kms_addfb_basic (addfb25-4-tiled) [113.347630] Starting subtest: addfb25-4-tiled [113.348887] Subtest addfb25-4-tiled: SUCCESS (0.000s) [113.455983] [055/165] (893s left) kms_addfb_basic (addfb25-bad-modifier) [113.548188] Starting subtest: addfb25-bad-modifier [113.549229] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [113.689679] [056/165] (893s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [113.781110] Starting subtest: addfb25-framebuffer-vs-set-tiling [113.782210] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.921211] [057/165] (893s left) kms_addfb_basic (addfb25-modifier-no-flag) [114.010736] Starting subtest: addfb25-modifier-no-flag [114.011923] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [114.157402] [058/165] (893s left) kms_addfb_basic (addfb25-x-tiled-legacy) [114.247035] Starting subtest: addfb25-x-tiled-legacy [114.248222] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [114.389634] [059/165] (892s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [114.484278] Starting subtest: addfb25-x-tiled-mismatch-legacy [114.485390] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [114.623472] [060/165] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [114.743858] Starting subtest: addfb25-yf-tiled-legacy [114.745046] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [114.838432] [061/165] (892s left) kms_addfb_basic (addfb25-y-tiled-legacy) [114.957217] Starting subtest: addfb25-y-tiled-legacy [114.958306] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [115.073824] [062/165] (892s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [115.193635] Starting subtest: addfb25-y-tiled-small-legacy [115.194774] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [115.304220] [063/165] (892s left) kms_addfb_basic (bad-pitch-0) [115.394883] Starting subtest: bad-pitch-0 [115.396083] Subtest bad-pitch-0: SUCCESS (0.000s) [115.535594] [064/165] (891s left) kms_addfb_basic (bad-pitch-1024) [115.627101] Starting subtest: bad-pitch-1024 [115.628147] Subtest bad-pitch-1024: SUCCESS (0.000s) [115.758419] [065/165] (891s left) kms_addfb_basic (bad-pitch-128) [115.848483] Starting subtest: bad-pitch-128 [115.849605] Subtest bad-pitch-128: SUCCESS (0.000s) [115.992523] [066/165] (891s left) kms_addfb_basic (bad-pitch-256) [116.083469] Starting subtest: bad-pitch-256 [116.084715] Subtest bad-pitch-256: SUCCESS (0.000s) [116.224198] [067/165] (891s left) kms_addfb_basic (bad-pitch-32) [116.313456] Starting subtest: bad-pitch-32 [116.315058] Subtest bad-pitch-32: SUCCESS (0.000s) [116.457288] [068/165] (891s left) kms_addfb_basic (bad-pitch-63) [116.547639] Starting subtest: bad-pitch-63 [116.548975] Subtest bad-pitch-63: SUCCESS (0.000s) [116.693831] [069/165] (891s left) kms_addfb_basic (bad-pitch-65536) [116.785112] Starting subtest: bad-pitch-65536 [116.786230] Subtest bad-pitch-65536: SUCCESS (0.000s) [116.926883] [070/165] (890s left) kms_addfb_basic (bad-pitch-999) [117.019032] Starting subtest: bad-pitch-999 [117.020164] Subtest bad-pitch-999: SUCCESS (0.000s) [117.140771] [071/165] (890s left) kms_addfb_basic (basic) [117.233128] Starting subtest: basic [117.234272] Subtest basic: SUCCESS (0.000s) [117.376480] [072/165] (890s left) kms_addfb_basic (basic-x-tiled-legacy) [117.468545] Starting subtest: basic-x-tiled-legacy [117.469591] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [117.609284] [073/165] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [117.700499] Starting subtest: basic-y-tiled-legacy [117.701555] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.844334] [074/165] (890s left) kms_addfb_basic (bo-too-small) [117.964541] Starting subtest: bo-too-small [117.965622] Subtest bo-too-small: SUCCESS (0.000s) [118.077594] [075/165] (889s left) kms_addfb_basic (bo-too-small-due-to-tiling) [118.196469] Starting subtest: bo-too-small-due-to-tiling [118.197602] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [118.312143] [076/165] (889s left) kms_addfb_basic (clobberred-modifier) [118.401446] Starting subtest: clobberred-modifier [118.402543] Subtest clobberred-modifier: SUCCESS (0.000s) [118.543518] [077/165] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.634090] Starting subtest: framebuffer-vs-set-tiling [118.635221] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.761123] [078/165] (889s left) kms_addfb_basic (invalid-get-prop) [118.851597] Starting subtest: invalid-get-prop [118.852710] Subtest invalid-get-prop: SUCCESS (0.000s) [118.971349] [079/165] (889s left) kms_addfb_basic (invalid-get-prop-any) [119.063277] Starting subtest: invalid-get-prop-any [119.064333] Subtest invalid-get-prop-any: SUCCESS (0.000s) [119.189757] [080/165] (888s left) kms_addfb_basic (invalid-set-prop) [119.280189] Starting subtest: invalid-set-prop [119.281230] Subtest invalid-set-prop: SUCCESS (0.000s) [119.411152] [081/165] (888s left) kms_addfb_basic (invalid-set-prop-any) [119.501265] Starting subtest: invalid-set-prop-any [119.502426] Subtest invalid-set-prop-any: SUCCESS (0.000s) [119.632370] [082/165] (888s left) kms_addfb_basic (no-handle) [119.722222] Starting subtest: no-handle [119.723358] Subtest no-handle: SUCCESS (0.000s) [119.862379] [083/165] (888s left) kms_addfb_basic (size-max) [119.982161] Starting subtest: size-max [119.983357] Subtest size-max: SUCCESS (0.000s) [120.095306] [084/165] (888s left) kms_addfb_basic (small-bo) [120.215530] Starting subtest: small-bo [120.216637] Subtest small-bo: SUCCESS (0.000s) [120.326274] [085/165] (887s left) kms_addfb_basic (tile-pitch-mismatch) [120.417297] Starting subtest: tile-pitch-mismatch [120.418416] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [120.564446] [086/165] (887s left) kms_addfb_basic (too-high) [120.684369] Starting subtest: too-high [120.685474] Subtest too-high: SUCCESS (0.001s) [120.814206] [087/165] (887s left) kms_addfb_basic (too-wide) [120.934370] Starting subtest: too-wide [120.935519] Subtest too-wide: SUCCESS (0.000s) [121.047477] [088/165] (887s left) kms_addfb_basic (unused-handle) [121.139374] Starting subtest: unused-handle [121.140489] Subtest unused-handle: SUCCESS (0.000s) [121.276206] [089/165] (887s left) kms_addfb_basic (unused-modifier) [121.366734] Starting subtest: unused-modifier [121.367890] Subtest unused-modifier: SUCCESS (0.000s) [121.491857] [090/165] (886s left) kms_addfb_basic (unused-offsets) [121.584105] Starting subtest: unused-offsets [121.585275] Subtest unused-offsets: SUCCESS (0.000s) [121.731452] [091/165] (886s left) kms_addfb_basic (unused-pitches) [121.822496] Starting subtest: unused-pitches [121.823858] Subtest unused-pitches: SUCCESS (0.000s) [121.965082] [092/165] (886s left) kms_busy (basic) [122.090579] Starting subtest: basic [122.091835] Starting dynamic subtest: flip [123.107764] Dynamic subtest flip: SUCCESS (1.012s) [123.132976] Starting dynamic subtest: modeset [126.916648] Dynamic subtest modeset: SUCCESS (3.809s) [126.917770] Subtest basic: SUCCESS (4.823s) [127.896152] [093/165] (880s left) kms_prop_blob (basic) [127.988430] Starting subtest: basic [127.989650] Subtest basic: SUCCESS (0.000s) [128.079028] [094/165] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [128.197825] Starting subtest: basic-busy-flip-before-cursor-atomic [128.200263] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [128.293298] [095/165] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [128.411731] Starting subtest: basic-busy-flip-before-cursor-legacy [128.414119] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [128.516065] [096/165] (880s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [128.635716] Starting subtest: basic-flip-after-cursor-atomic [129.933348] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.298s) [130.911867] [097/165] (877s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [131.030317] Starting subtest: basic-flip-after-cursor-legacy [132.342040] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.311s) [133.288126] [098/165] (875s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [133.408560] Starting subtest: basic-flip-after-cursor-varying-size [134.688348] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.280s) [135.637267] [099/165] (873s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [135.755732] Starting subtest: basic-flip-before-cursor-atomic [137.060530] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.302s) [137.998565] [100/165] (870s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [138.118494] Starting subtest: basic-flip-before-cursor-legacy [139.417421] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.300s) [140.372322] [101/165] (868s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [140.491722] Starting subtest: basic-flip-before-cursor-varying-size [141.796632] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.301s) [142.741172] [102/165] (866s left) kms_dsc (dsc-basic) [142.862695] Subtest dsc-basic: SKIP (0.000s) [142.915449] [103/165] (866s left) kms_flip (basic-flip-vs-dpms) [143.037343] Starting subtest: basic-flip-vs-dpms [143.040938] Starting dynamic subtest: A-eDP1 [145.924870] Dynamic subtest A-eDP1: SUCCESS (2.882s) [145.947899] Starting dynamic subtest: B-eDP1 [148.353938] Dynamic subtest B-eDP1: SUCCESS (2.430s) [148.378088] Starting dynamic subtest: C-eDP1 [150.742025] Dynamic subtest C-eDP1: SUCCESS (2.385s) [150.743271] Subtest basic-flip-vs-dpms: SUCCESS (7.705s) [151.683672] [104/165] (857s left) kms_flip (basic-flip-vs-modeset) [151.804417] Starting subtest: basic-flip-vs-modeset [151.808513] Starting dynamic subtest: A-eDP1 [154.687451] Dynamic subtest A-eDP1: SUCCESS (2.879s) [154.715117] Starting dynamic subtest: B-eDP1 [157.054790] Dynamic subtest B-eDP1: SUCCESS (2.366s) [157.079073] Starting dynamic subtest: C-eDP1 [159.427263] Dynamic subtest C-eDP1: SUCCESS (2.368s) [159.428306] Subtest basic-flip-vs-modeset: SUCCESS (7.621s) [160.403895] [105/165] (848s left) kms_flip (basic-flip-vs-wf_vblank) [160.526900] Starting subtest: basic-flip-vs-wf_vblank [160.530132] Starting dynamic subtest: A-eDP1 [162.859487] Dynamic subtest A-eDP1: SUCCESS (2.328s) [162.885038] Starting dynamic subtest: B-eDP1 [165.143500] Dynamic subtest B-eDP1: SUCCESS (2.282s) [165.169278] Starting dynamic subtest: C-eDP1 [167.384620] Dynamic subtest C-eDP1: SUCCESS (2.239s) [167.391944] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.863s) [168.731864] [106/165] (840s left) kms_flip (basic-plain-flip) [168.854325] Starting subtest: basic-plain-flip [168.855458] Starting dynamic subtest: A-eDP1 [170.896231] Dynamic subtest A-eDP1: SUCCESS (2.038s) [170.921235] Starting dynamic subtest: B-eDP1 [172.862309] Dynamic subtest B-eDP1: SUCCESS (1.965s) [172.889310] Starting dynamic subtest: C-eDP1 [174.845381] Dynamic subtest C-eDP1: SUCCESS (1.981s) [174.851905] Subtest basic-plain-flip: SUCCESS (6.000s) [176.214786] [107/165] (832s left) kms_force_connector_basic (force-connector-state) [176.311785] Starting subtest: force-connector-state [176.898453] Subtest force-connector-state: SUCCESS (0.587s) [177.985421] [108/165] (831s left) kms_force_connector_basic (force-edid) [178.079496] Starting subtest: force-edid [178.339497] Subtest force-edid: SUCCESS (0.261s) [178.479267] [109/165] (830s left) kms_force_connector_basic (force-load-detect) [178.570757] Starting subtest: force-load-detect [178.573051] Subtest force-load-detect: SKIP (0.000s) [178.694572] [110/165] (830s left) kms_force_connector_basic (prune-stale-modes) [178.787913] Starting subtest: prune-stale-modes [179.106551] Subtest prune-stale-modes: SUCCESS (0.318s) [179.248142] [111/165] (829s left) kms_frontbuffer_tracking (basic) [179.375227] Starting subtest: basic [182.722937] Subtest basic: SUCCESS (3.346s) [182.857388] [112/165] (826s left) kms_hdmi_inject (inject-audio) [183.262265] Starting subtest: inject-audio [183.505355] Subtest inject-audio: SUCCESS (0.244s) [184.205756] [113/165] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [184.327913] Starting subtest: compare-crc-sanitycheck-xr24 [184.330599] Starting dynamic subtest: pipe-A-eDP-1 [185.024690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s) [185.053868] Starting dynamic subtest: pipe-B-eDP-1 [186.416738] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s) [186.445271] Starting dynamic subtest: pipe-C-eDP-1 [187.795486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s) [187.796640] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.468s) [188.759660] [114/165] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [188.880295] Starting subtest: compare-crc-sanitycheck-nv12 [188.881410] Starting dynamic subtest: pipe-A-eDP-1 [189.829304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.944s) [189.854648] Starting dynamic subtest: pipe-B-eDP-1 [191.217412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s) [191.243266] Starting dynamic subtest: pipe-C-eDP-1 [192.593561] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s) [192.594860] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.714s) [193.558904] [115/165] (815s left) kms_pipe_crc_basic (hang-read-crc) [193.678417] Starting subtest: hang-read-crc [193.679539] Starting dynamic subtest: pipe-A-eDP-1 [196.091940] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.411s) [196.118433] Starting dynamic subtest: pipe-B-eDP-1 [199.202360] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.106s) [199.227855] Starting dynamic subtest: pipe-C-eDP-1 [202.190648] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.986s) [202.191953] Subtest hang-read-crc: SUCCESS (8.514s) [203.157643] [116/165] (806s left) kms_pipe_crc_basic (nonblocking-crc) [203.277534] Starting subtest: nonblocking-crc [203.280479] Starting dynamic subtest: pipe-A-eDP-1 [204.178169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.896s) [204.204740] Starting dynamic subtest: pipe-B-eDP-1 [205.792391] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.611s) [205.819449] Starting dynamic subtest: pipe-C-eDP-1 [207.369481] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.573s) [207.370800] Subtest nonblocking-crc: SUCCESS (4.092s) [208.342937] [117/165] (801s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [208.464841] Starting subtest: nonblocking-crc-frame-sequence [208.468051] Starting dynamic subtest: pipe-A-eDP-1 [209.363432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.895s) [209.390430] Starting dynamic subtest: pipe-B-eDP-1 [210.977601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s) [211.004824] Starting dynamic subtest: pipe-C-eDP-1 [212.537405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.554s) [212.538712] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.072s) [213.466703] [118/165] (796s left) kms_pipe_crc_basic (read-crc) [213.586835] Starting subtest: read-crc [213.590047] Starting dynamic subtest: pipe-A-eDP-1 [214.419319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s) [214.446310] Starting dynamic subtest: pipe-B-eDP-1 [215.969099] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [215.995928] Starting dynamic subtest: pipe-C-eDP-1 [217.462718] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s) [217.463983] Subtest read-crc: SUCCESS (3.875s) [218.410654] [119/165] (791s left) kms_pipe_crc_basic (read-crc-frame-sequence) [218.532044] Starting subtest: read-crc-frame-sequence [218.535188] Starting dynamic subtest: pipe-A-eDP-1 [219.363106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s) [219.390185] Starting dynamic subtest: pipe-B-eDP-1 [220.876098] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.507s) [220.901741] Starting dynamic subtest: pipe-C-eDP-1 [222.352249] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s) [222.353579] Subtest read-crc-frame-sequence: SUCCESS (3.821s) [223.318753] [120/165] (786s left) kms_pm_backlight (basic-brightness) [223.439778] Starting subtest: basic-brightness [223.537727] Starting dynamic subtest: eDP-1 [224.120718] Dynamic subtest eDP-1: SUCCESS (0.583s) [224.122000] Subtest basic-brightness: SUCCESS (0.681s) [225.048260] [121/165] (784s left) kms_pm_rpm (basic-pci-d3-state) [226.888401] Starting subtest: basic-pci-d3-state [231.270377] Subtest basic-pci-d3-state: SUCCESS (4.380s) [231.484534] [122/165] (778s left) kms_pm_rpm (basic-rte) [231.573017] Starting subtest: basic-rte [237.734278] Subtest basic-rte: SUCCESS (6.159s) [243.128343] [123/165] (766s left) kms_psr (psr_primary_page_flip) [243.252371] Starting subtest: psr_primary_page_flip [243.253664] Starting dynamic subtest: eDP-1 [247.018142] Dynamic subtest eDP-1: SUCCESS (3.764s) [247.019904] Subtest psr_primary_page_flip: SUCCESS (3.767s) [247.958829] [124/165] (761s left) kms_psr (psr_cursor_plane_move) [248.081431] Starting subtest: psr_cursor_plane_move [248.082613] Starting dynamic subtest: eDP-1 [251.883302] Dynamic subtest eDP-1: SUCCESS (3.800s) [251.887050] Subtest psr_cursor_plane_move: SUCCESS (3.803s) [252.829136] [125/165] (756s left) kms_psr (psr_sprite_plane_onoff) [252.950957] Starting subtest: psr_sprite_plane_onoff [252.952260] Starting dynamic subtest: eDP-1 [256.834339] Dynamic subtest eDP-1: SUCCESS (3.883s) [256.835470] Subtest psr_sprite_plane_onoff: SUCCESS (3.886s) [257.814443] [126/165] (752s left) kms_psr (psr_primary_mmap_gtt) [257.935407] Starting subtest: psr_primary_mmap_gtt [257.939031] Starting dynamic subtest: eDP-1 [261.738191] Dynamic subtest eDP-1: SUCCESS (3.798s) [261.739350] Subtest psr_primary_mmap_gtt: SUCCESS (3.801s) [262.679210] [127/165] (747s left) kms_setmode (basic-clone-single-crtc) [262.771467] Starting subtest: basic-clone-single-crtc [262.774873] Subtest basic-clone-single-crtc: SKIP (0.001s) [262.880984] [128/165] (747s left) i915_pm_rps (basic-api) [262.981775] Starting subtest: basic-api [262.986336] Subtest basic-api: SUCCESS (0.005s) [263.073802] [129/165] (746s left) prime_self_import (basic-llseek-bad) [263.161959] Starting subtest: basic-llseek-bad [263.166584] Subtest basic-llseek-bad: SUCCESS (0.003s) [263.295927] [130/165] (746s left) prime_self_import (basic-llseek-size) [263.385916] Starting subtest: basic-llseek-size [263.388262] Subtest basic-llseek-size: SUCCESS (0.004s) [263.496036] [131/165] (746s left) prime_self_import (basic-with_fd_dup) [263.582089] Starting subtest: basic-with_fd_dup [263.586677] Subtest basic-with_fd_dup: SUCCESS (0.005s) [263.696479] [132/165] (746s left) prime_self_import (basic-with_one_bo) [263.782258] Starting subtest: basic-with_one_bo [263.786840] Subtest basic-with_one_bo: SUCCESS (0.005s) [263.872916] [133/165] (746s left) prime_self_import (basic-with_one_bo_two_files) [263.960441] Starting subtest: basic-with_one_bo_two_files [263.964913] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [264.080193] [134/165] (746s left) prime_self_import (basic-with_two_bos) [264.167254] Starting subtest: basic-with_two_bos [264.171919] Subtest basic-with_two_bos: SUCCESS (0.005s) [264.278942] [135/165] (745s left) prime_vgem (basic-fence-flip) [264.386644] Starting subtest: basic-fence-flip [264.927754] Subtest basic-fence-flip: SUCCESS (0.541s) [265.067066] [136/165] (745s left) prime_vgem (basic-fence-mmap) [265.182155] Starting subtest: basic-fence-mmap [265.232398] Subtest basic-fence-mmap: SUCCESS (0.050s) [265.330669] [137/165] (744s left) prime_vgem (basic-fence-read) [265.452273] Starting subtest: basic-fence-read [265.528475] Subtest basic-fence-read: SUCCESS (0.076s) [265.631611] [138/165] (744s left) prime_vgem (basic-gtt) [265.739491] Starting subtest: basic-gtt [265.763826] Subtest basic-gtt: SUCCESS (0.025s) [265.882061] [139/165] (744s left) prime_vgem (basic-read) [265.997640] Starting subtest: basic-read [266.034897] Subtest basic-read: SUCCESS (0.037s) [266.150156] [140/165] (744s left) prime_vgem (basic-write) [266.259430] Starting subtest: basic-write [266.302825] Subtest basic-write: SUCCESS (0.043s) [266.402914] [141/165] (744s left) vgem_basic (setversion) [266.497160] Starting subtest: setversion [266.499678] Subtest setversion: SUCCESS (0.000s) [266.582563] [142/165] (743s left) vgem_basic (create) [266.684287] Starting subtest: create [266.685602] Subtest create: SUCCESS (0.000s) [266.765598] [143/165] (743s left) vgem_basic (debugfs) [266.864293] Starting subtest: debugfs [266.867758] Subtest debugfs: SUCCESS (0.003s) [266.947274] [144/165] (743s left) vgem_basic (dmabuf-export) [267.048408] Starting subtest: dmabuf-export [267.053321] Subtest dmabuf-export: SUCCESS (0.003s) [267.167211] [145/165] (743s left) vgem_basic (dmabuf-fence) [267.264913] Starting subtest: dmabuf-fence [267.266221] Subtest dmabuf-fence: SUCCESS (0.001s) [267.352120] [146/165] (743s left) vgem_basic (dmabuf-fence-before) [267.451214] Starting subtest: dmabuf-fence-before [267.452706] Subtest dmabuf-fence-before: SUCCESS (0.001s) [267.531434] [147/165] (743s left) vgem_basic (dmabuf-mmap) [267.632349] Starting subtest: dmabuf-mmap [267.657723] Subtest dmabuf-mmap: SUCCESS (0.026s) [267.730833] [148/165] (742s left) vgem_basic (mmap) [267.833142] Starting subtest: mmap [267.848921] Subtest mmap: SUCCESS (0.017s) [267.930286] [149/165] (742s left) vgem_basic (second-client) [268.032875] Starting subtest: second-client [268.067797] Subtest second-client: SUCCESS (0.034s) [268.151388] [150/165] (742s left) vgem_basic (sysfs) [268.249107] Starting subtest: sysfs [268.250341] Subtest sysfs: SUCCESS (0.001s) [268.332293] [151/165] (742s left) core_hotunplug (unbind-rebind) [268.467675] Starting subtest: unbind-rebind [274.659327] Subtest unbind-rebind: SUCCESS (6.194s) [274.687836] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1832 [max: 8192] direct dependencies: 18280 [max: 32768] indirect dependencies: 138665 all direct dependencies: 380152 dependency chains: 25697 [max: 131072] dependency chain hlocks used: 108625 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 285 in-softirq chains: 614 in-process chains: 24798 stack-trace entries: 178618 [max: 1048576] number of stack traces: 8924 number of stack hash chains: 6863 combined max dependencies: 66928814 hardirq-safe locks: 107 hardirq-unsafe locks: 1077 softirq-safe locks: 215 softirq-unsafe locks: 989 irq-safe locks: 229 irq-unsafe locks: 1077 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 336 softirq-read-safe locks: 8 softirq-read-unsafe locks: 331 irq-read-safe locks: 8 irq-read-unsafe locks: 336 uncategorized locks: 304 unused locks: 1 max locking depth: 16 max bfs queue depth: 432 max lock class index: 2003 chain lookup misses: 29680 chain lookup hits: 122063933 cyclic checks: 29745 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4793 find-mask backwards checks: 3085 hardirq on events: 71394168 hardirq off events: 71394165 redundant hardirq ons: 32 redundant hardirq offs: 19 softirq on events: 670784 softirq off events: 670784 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 176 zapped lock chains: 3911 large chain blocks: 1 [274.689383] Closing watchdogs Done.