[41.550710] Initializing watchdogs [41.550793] /dev/watchdog0 [41.560118] [001/161] (960s left) i915_module_load (load) [41.636246] Starting subtest: load [43.471333] Subtest load: SUCCESS (1.840s) [43.492179] [002/161] (958s left) core_auth (basic-auth) [45.078154] Starting subtest: basic-auth [45.086616] Subtest basic-auth: SUCCESS (0.001s) [45.189225] [003/161] (956s left) debugfs_test (read_all_entries) [45.247748] Starting subtest: read_all_entries [45.419067] Subtest read_all_entries: SUCCESS (0.173s) [45.514988] [004/161] (956s left) debugfs_test (basic-hwmon) [45.576653] Starting subtest: basic-hwmon [45.588160] Subtest basic-hwmon: SKIP (0.000s) [45.669270] [005/161] (956s left) debugfs_test (sysfs) [45.739498] Starting subtest: sysfs [45.755868] Subtest sysfs: SUCCESS (0.020s) [45.856493] [006/161] (956s left) fbdev (eof) [45.907220] Starting subtest: eof [45.913092] Subtest eof: SUCCESS (0.000s) [45.954861] [007/161] (956s left) fbdev (info) [45.999126] Starting subtest: info [46.006953] Subtest info: SUCCESS (0.000s) [46.053783] [008/161] (956s left) fbdev (nullptr) [46.086508] Starting subtest: nullptr [46.097027] Subtest nullptr: SUCCESS (0.000s) [46.138781] [009/161] (956s left) fbdev (read) [46.189124] Starting subtest: read [47.161034] Subtest read: SUCCESS (0.965s) [47.212942] [010/161] (955s left) fbdev (write) [47.260861] Starting subtest: write [47.895523] Subtest write: SUCCESS (0.616s) [47.941306] [011/161] (954s left) gem_basic (bad-close) [48.003750] Starting subtest: bad-close [48.015605] Subtest bad-close: SUCCESS (0.000s) [48.082448] [012/161] (954s left) gem_basic (create-close) [48.137823] Starting subtest: create-close [48.153238] Subtest create-close: SUCCESS (0.000s) [48.212839] [013/161] (954s left) gem_basic (create-fd-close) [48.267726] Starting subtest: create-fd-close [48.282704] Subtest create-fd-close: SUCCESS (0.000s) [48.351039] [014/161] (954s left) gem_busy (busy@all-engines) [48.421769] Starting subtest: busy [48.430498] Starting dynamic subtest: all-engines [48.466723] Dynamic subtest all-engines: SUCCESS (0.048s) [48.472624] Subtest busy: SUCCESS (0.048s) [50.129521] [015/161] (952s left) gem_close_race (basic-process) [50.193988] Starting subtest: basic-process [50.246265] Subtest basic-process: SUCCESS (0.060s) [50.436254] [016/161] (952s left) gem_close_race (basic-threads) [50.501200] Starting subtest: basic-threads [51.729210] Subtest basic-threads: SUCCESS (1.212s) [51.907619] [017/161] (950s left) gem_ctx_create (basic) [51.972053] Starting subtest: basic [51.978347] Subtest basic: SUCCESS (0.000s) [52.147958] [018/161] (950s left) gem_ctx_create (basic-files) [52.224042] Starting subtest: basic-files [54.812498] Subtest basic-files: SUCCESS (2.559s) [56.142681] [019/161] (946s left) gem_ctx_exec (basic) [56.201065] Starting subtest: basic [56.206657] Subtest basic: SUCCESS (0.006s) [56.294060] [020/161] (946s left) gem_exec_basic (basic) [56.344131] Starting subtest: basic [56.351878] Starting dynamic subtest: rcs0-smem [56.357623] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [56.368516] Starting dynamic subtest: bcs0-smem [56.376863] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [56.385501] Starting dynamic subtest: vcs0-smem [56.391068] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [56.399483] Starting dynamic subtest: vcs1-smem [56.405088] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [56.413580] Starting dynamic subtest: vecs0-smem [56.419208] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [56.427972] Starting dynamic subtest: ccs0-smem [56.436493] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [56.442327] Subtest basic: SUCCESS (0.010s) [58.129337] [021/161] (944s left) gem_exec_create (basic) [58.190043] Starting subtest: basic [58.195656] Starting dynamic subtest: smem [61.103125] Dynamic subtest smem: SUCCESS (2.897s) [61.111833] Subtest basic: SUCCESS (2.897s) [61.276978] [022/161] (941s left) gem_exec_fence (basic-busy) [61.448170] Starting subtest: basic-busy [61.457565] Starting dynamic subtest: rcs0 [61.507183] Dynamic subtest rcs0: SUCCESS (0.065s) [61.518831] Starting dynamic subtest: bcs0 [61.566720] Dynamic subtest bcs0: SUCCESS (0.056s) [61.578443] Starting dynamic subtest: vcs0 [61.624899] Dynamic subtest vcs0: SUCCESS (0.061s) [61.636809] Starting dynamic subtest: vcs1 [61.683777] Dynamic subtest vcs1: SUCCESS (0.057s) [61.693973] Starting dynamic subtest: vecs0 [61.747498] Dynamic subtest vecs0: SUCCESS (0.062s) [61.758840] Starting dynamic subtest: ccs0 [61.807058] Dynamic subtest ccs0: SUCCESS (0.060s) [61.813203] Subtest basic-busy: SUCCESS (0.360s) [63.242656] [023/161] (939s left) gem_exec_fence (basic-wait) [63.419151] Starting subtest: basic-wait [63.425087] Starting dynamic subtest: rcs0 [63.496384] Dynamic subtest rcs0: SUCCESS (0.086s) [63.512575] Starting dynamic subtest: bcs0 [63.556700] Dynamic subtest bcs0: SUCCESS (0.057s) [63.566952] Starting dynamic subtest: vcs0 [63.615146] Dynamic subtest vcs0: SUCCESS (0.061s) [63.629301] Starting dynamic subtest: vcs1 [63.673388] Dynamic subtest vcs1: SUCCESS (0.055s) [63.684835] Starting dynamic subtest: vecs0 [63.731213] Dynamic subtest vecs0: SUCCESS (0.058s) [63.743088] Starting dynamic subtest: ccs0 [63.789116] Dynamic subtest ccs0: SUCCESS (0.061s) [63.798462] Subtest basic-wait: SUCCESS (0.379s) [65.237251] [024/161] (937s left) gem_exec_fence (basic-await) [65.413184] Starting subtest: basic-await [65.418911] Starting dynamic subtest: rcs0 [65.487440] Dynamic subtest rcs0: SUCCESS (0.076s) [65.500552] Starting dynamic subtest: bcs0 [65.561892] Dynamic subtest bcs0: SUCCESS (0.072s) [65.573724] Starting dynamic subtest: vcs0 [65.628994] Dynamic subtest vcs0: SUCCESS (0.067s) [65.642831] Starting dynamic subtest: vcs1 [65.701433] Dynamic subtest vcs1: SUCCESS (0.073s) [65.713407] Starting dynamic subtest: vecs0 [65.781826] Dynamic subtest vecs0: SUCCESS (0.079s) [65.794072] Starting dynamic subtest: ccs0 [65.847362] Dynamic subtest ccs0: SUCCESS (0.067s) [65.855090] Subtest basic-await: SUCCESS (0.436s) [67.208060] [025/161] (935s left) gem_exec_fence (nb-await) [67.388456] Starting subtest: nb-await [67.394334] Starting dynamic subtest: rcs0 [67.461397] Dynamic subtest rcs0: SUCCESS (0.078s) [67.472147] Starting dynamic subtest: bcs0 [67.522625] Dynamic subtest bcs0: SUCCESS (0.062s) [67.535344] Starting dynamic subtest: vcs0 [67.584814] Dynamic subtest vcs0: SUCCESS (0.061s) [67.596595] Starting dynamic subtest: vcs1 [67.646692] Dynamic subtest vcs1: SUCCESS (0.060s) [67.656111] Starting dynamic subtest: vecs0 [67.705767] Dynamic subtest vecs0: SUCCESS (0.060s) [67.716222] Starting dynamic subtest: ccs0 [67.767583] Dynamic subtest ccs0: SUCCESS (0.062s) [67.773670] Subtest nb-await: SUCCESS (0.384s) [69.182521] [026/161] (933s left) gem_exec_gttfill (basic) [69.247956] Starting subtest: basic [71.584044] Subtest basic: SUCCESS (2.330s) [71.763241] [027/161] (931s left) gem_exec_parallel (engines) [71.845951] Starting subtest: engines [71.854859] Starting dynamic subtest: basic [77.065448] Dynamic subtest basic: SUCCESS (5.210s) [77.078031] Starting dynamic subtest: contexts [81.370150] Dynamic subtest contexts: SUCCESS (4.303s) [81.383209] Starting dynamic subtest: fds [85.182976] Dynamic subtest fds: SUCCESS (3.812s) [85.196261] Starting dynamic subtest: userptr [87.083058] Dynamic subtest userptr: SUCCESS (1.899s) [87.092424] Subtest engines: SUCCESS (15.224s) [87.262316] [028/161] (915s left) gem_exec_store (basic) [87.331952] Starting subtest: basic [87.445665] Subtest basic: SUCCESS (0.123s) [87.618346] [029/161] (915s left) gem_flink_basic (bad-flink) [87.674051] Starting subtest: bad-flink [87.680170] Subtest bad-flink: SUCCESS (0.000s) [87.781499] [030/161] (915s left) gem_flink_basic (bad-open) [87.837510] Starting subtest: bad-open [87.843627] Subtest bad-open: SUCCESS (0.000s) [87.918232] [031/161] (914s left) gem_flink_basic (basic) [87.976436] Starting subtest: basic [87.982260] Subtest basic: SUCCESS (0.000s) [88.061546] [032/161] (914s left) gem_flink_basic (double-flink) [88.114187] Starting subtest: double-flink [88.122445] Subtest double-flink: SUCCESS (0.000s) [88.201352] [033/161] (914s left) gem_flink_basic (flink-lifetime) [88.262968] Starting subtest: flink-lifetime [88.268421] Subtest flink-lifetime: SUCCESS (0.001s) [88.337590] [034/161] (914s left) gem_huc_copy (huc-copy) [88.404193] Starting subtest: huc-copy [88.409716] Subtest huc-copy: SUCCESS (0.005s) [88.539398] [035/161] (914s left) gem_linear_blits (basic) [88.685670] Starting subtest: basic [88.701174] Subtest basic: SUCCESS (0.016s) [88.820878] [036/161] (914s left) gem_mmap (basic) [88.900029] Subtest basic: SKIP (0.000s) [88.934678] [037/161] (914s left) gem_mmap_gtt (basic) [89.008052] Subtest basic: SKIP (0.000s) [89.058826] [038/161] (914s left) gem_render_linear_blits (basic) [89.123819] Starting subtest: basic [89.155813] Subtest basic: SUCCESS (0.020s) [89.216126] [039/161] (913s left) gem_render_tiled_blits (basic) [89.275171] Subtest basic: SKIP (0.000s) [89.337714] [040/161] (913s left) gem_ringfill (basic-all) [95.157296] Starting subtest: basic-all [96.315346] Subtest basic-all: SUCCESS (1.165s) [96.445593] [041/161] (906s left) gem_softpin (allocator-basic) [96.491625] Starting subtest: allocator-basic [96.542348] Subtest allocator-basic: SUCCESS (0.050s) [96.667354] [042/161] (906s left) gem_softpin (allocator-basic-reserve) [96.722186] Starting subtest: allocator-basic-reserve [96.772207] Subtest allocator-basic-reserve: SUCCESS (0.048s) [96.900792] [043/161] (906s left) gem_softpin (safe-alignment) [96.974653] Starting subtest: safe-alignment [96.991928] Subtest safe-alignment: SUCCESS (0.016s) [98.188387] [044/161] (905s left) gem_sync (basic-all) [98.306829] Starting subtest: basic-all [102.124454] Subtest basic-all: SUCCESS (3.858s) [102.299121] [045/161] (900s left) gem_sync (basic-each) [102.410194] Starting subtest: basic-each [104.797930] Subtest basic-each: SUCCESS (2.434s) [104.981436] [046/161] (898s left) gem_tiled_blits (basic) [105.045618] Subtest basic: SKIP (0.000s) [105.090992] [047/161] (898s left) gem_tiled_fence_blits (basic) [105.148504] Subtest basic: SKIP (0.000s) [105.194881] [048/161] (898s left) gem_tiled_pread_basic [105.311967] [049/161] (898s left) gem_wait (busy@all-engines) [105.364532] Starting subtest: busy [105.372265] Starting dynamic subtest: all-engines [107.116117] Dynamic subtest all-engines: SUCCESS (1.748s) [107.124951] Subtest busy: SUCCESS (1.748s) [107.303442] [050/161] (896s left) gem_wait (wait@all-engines) [107.364974] Starting subtest: wait [107.370736] Starting dynamic subtest: all-engines [109.100074] Dynamic subtest all-engines: SUCCESS (1.726s) [109.106230] Subtest wait: SUCCESS (1.726s) [109.283415] [051/161] (894s left) i915_getparams_basic (basic-eu-total) [109.342560] Starting subtest: basic-eu-total [109.354970] Subtest basic-eu-total: SUCCESS (0.000s) [109.423480] [052/161] (894s left) i915_getparams_basic (basic-subslice-total) [109.469214] Starting subtest: basic-subslice-total [109.480106] Subtest basic-subslice-total: SUCCESS (0.000s) [109.535916] [053/161] (893s left) i915_hangman (error-state-basic) [109.599249] Starting subtest: error-state-basic [109.716773] Subtest error-state-basic: SUCCESS (0.117s) [109.786117] [054/161] (893s left) i915_pciid [109.942257] [055/161] (893s left) kms_addfb_basic (addfb25-4-tiled) [110.026713] Starting subtest: addfb25-4-tiled [110.032103] Subtest addfb25-4-tiled: SUCCESS (0.000s) [110.106532] [056/161] (893s left) kms_addfb_basic (addfb25-bad-modifier) [110.151679] Starting subtest: addfb25-bad-modifier [110.157264] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [110.253645] [057/161] (893s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [110.322162] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [110.451835] [058/161] (893s left) kms_addfb_basic (addfb25-modifier-no-flag) [110.504224] Starting subtest: addfb25-modifier-no-flag [110.510038] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [110.657016] [059/161] (892s left) kms_addfb_basic (addfb25-x-tiled-legacy) [110.725471] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [110.850501] [060/161] (892s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [110.914980] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [111.019758] [061/161] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [111.115802] Starting subtest: addfb25-yf-tiled-legacy [111.121552] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [111.216911] [062/161] (892s left) kms_addfb_basic (addfb25-y-tiled-legacy) [111.295260] Starting subtest: addfb25-y-tiled-legacy [111.300754] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [111.365879] [063/161] (892s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [111.466067] Starting subtest: addfb25-y-tiled-small-legacy [111.477056] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [111.570885] [064/161] (892s left) kms_addfb_basic (bad-pitch-0) [111.623305] Starting subtest: bad-pitch-0 [111.628901] Subtest bad-pitch-0: SUCCESS (0.000s) [111.755873] [065/161] (891s left) kms_addfb_basic (bad-pitch-1024) [111.815470] Starting subtest: bad-pitch-1024 [111.821112] Subtest bad-pitch-1024: SUCCESS (0.000s) [111.948133] [066/161] (891s left) kms_addfb_basic (bad-pitch-128) [112.011774] Starting subtest: bad-pitch-128 [112.018085] Subtest bad-pitch-128: SUCCESS (0.000s) [112.140678] [067/161] (891s left) kms_addfb_basic (bad-pitch-256) [112.191799] Starting subtest: bad-pitch-256 [112.197590] Subtest bad-pitch-256: SUCCESS (0.000s) [112.307617] [068/161] (891s left) kms_addfb_basic (bad-pitch-32) [112.365140] Starting subtest: bad-pitch-32 [112.370752] Subtest bad-pitch-32: SUCCESS (0.000s) [112.486357] [069/161] (891s left) kms_addfb_basic (bad-pitch-63) [112.539074] Starting subtest: bad-pitch-63 [112.545187] Subtest bad-pitch-63: SUCCESS (0.000s) [112.673923] [070/161] (891s left) kms_addfb_basic (bad-pitch-65536) [112.725580] Starting subtest: bad-pitch-65536 [112.732128] Subtest bad-pitch-65536: SUCCESS (0.000s) [112.842617] [071/161] (890s left) kms_addfb_basic (bad-pitch-999) [112.907260] Starting subtest: bad-pitch-999 [112.913185] Subtest bad-pitch-999: SUCCESS (0.000s) [113.042300] [072/161] (890s left) kms_addfb_basic (basic) [113.086499] Starting subtest: basic [113.092154] Subtest basic: SUCCESS (0.000s) [113.211248] [073/161] (890s left) kms_addfb_basic (basic-x-tiled-legacy) [113.275868] Starting subtest: basic-x-tiled-legacy [113.287702] Subtest basic-x-tiled-legacy: SKIP (0.000s) [113.403888] [074/161] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [113.470643] Starting subtest: basic-y-tiled-legacy [113.482452] Subtest basic-y-tiled-legacy: SKIP (0.000s) [113.604142] [075/161] (890s left) kms_addfb_basic (bo-too-small) [113.694593] Starting subtest: bo-too-small [113.700166] Subtest bo-too-small: SUCCESS (0.000s) [113.759166] [076/161] (890s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.855417] Starting subtest: bo-too-small-due-to-tiling [113.865908] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [113.946275] [077/161] (890s left) kms_addfb_basic (clobberred-modifier) [114.005850] Starting subtest: clobberred-modifier [114.017224] Subtest clobberred-modifier: SKIP (0.000s) [114.136068] [078/161] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [114.189762] Starting subtest: framebuffer-vs-set-tiling [114.200610] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [114.305409] [079/161] (889s left) kms_addfb_basic (invalid-get-prop) [114.376757] Starting subtest: invalid-get-prop [114.383068] Subtest invalid-get-prop: SUCCESS (0.000s) [114.506990] [080/161] (889s left) kms_addfb_basic (invalid-get-prop-any) [114.566784] Starting subtest: invalid-get-prop-any [114.572510] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.677930] [081/161] (889s left) kms_addfb_basic (invalid-set-prop) [114.736750] Starting subtest: invalid-set-prop [114.742404] Subtest invalid-set-prop: SUCCESS (0.000s) [114.871096] [082/161] (889s left) kms_addfb_basic (invalid-set-prop-any) [114.937904] Starting subtest: invalid-set-prop-any [114.943669] Subtest invalid-set-prop-any: SUCCESS (0.000s) [115.038180] [083/161] (889s left) kms_addfb_basic (no-handle) [115.097296] Starting subtest: no-handle [115.102970] Subtest no-handle: SUCCESS (0.000s) [115.225295] [084/161] (888s left) kms_addfb_basic (size-max) [115.314089] Starting subtest: size-max [115.319570] Subtest size-max: SUCCESS (0.000s) [115.393235] [085/161] (888s left) kms_addfb_basic (small-bo) [115.477730] Starting subtest: small-bo [115.484033] Subtest small-bo: SUCCESS (0.000s) [115.560167] [086/161] (888s left) kms_addfb_basic (tile-pitch-mismatch) [115.631329] Starting subtest: tile-pitch-mismatch [115.643411] Subtest tile-pitch-mismatch: SKIP (0.000s) [115.759364] [087/161] (888s left) kms_addfb_basic (too-high) [115.864114] Starting subtest: too-high [115.869854] Subtest too-high: SUCCESS (0.000s) [115.925692] [088/161] (888s left) kms_addfb_basic (too-wide) [116.016079] Starting subtest: too-wide [116.021773] Subtest too-wide: SUCCESS (0.000s) [116.099631] [089/161] (888s left) kms_addfb_basic (unused-handle) [116.149189] Starting subtest: unused-handle [116.156544] Subtest unused-handle: SUCCESS (0.000s) [116.289048] [090/161] (887s left) kms_addfb_basic (unused-modifier) [116.348910] Starting subtest: unused-modifier [116.354616] Subtest unused-modifier: SUCCESS (0.000s) [116.481740] [091/161] (887s left) kms_addfb_basic (unused-offsets) [116.538918] Starting subtest: unused-offsets [116.546751] Subtest unused-offsets: SUCCESS (0.000s) [116.652512] [092/161] (887s left) kms_addfb_basic (unused-pitches) [116.701829] Starting subtest: unused-pitches [116.707621] Subtest unused-pitches: SUCCESS (0.000s) [116.837285] [093/161] (887s left) kms_busy (basic) [116.925072] Starting subtest: basic [116.932795] Starting dynamic subtest: flip [117.716700] Dynamic subtest flip: SUCCESS (0.792s) [117.728172] Starting dynamic subtest: modeset [121.423919] Dynamic subtest modeset: SUCCESS (3.708s) [121.429780] Subtest basic: SUCCESS (4.501s) [122.340236] [094/161] (882s left) kms_prop_blob (basic) [122.401592] Starting subtest: basic [122.408921] Subtest basic: SUCCESS (0.000s) [122.470366] [095/161] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [122.593630] Starting subtest: basic-busy-flip-before-cursor-atomic [122.605157] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [122.709389] [096/161] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [122.829246] Starting subtest: basic-busy-flip-before-cursor-legacy [122.841614] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [122.962219] [097/161] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [123.079787] Starting subtest: basic-flip-after-cursor-atomic [124.307708] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.225s) [125.213609] [098/161] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [125.333750] Starting subtest: basic-flip-after-cursor-legacy [126.538366] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.207s) [127.453766] [099/161] (876s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [127.573291] Starting subtest: basic-flip-after-cursor-varying-size [128.784704] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.209s) [129.702381] [100/161] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [129.819142] Starting subtest: basic-flip-before-cursor-atomic [131.041509] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.224s) [131.939140] [101/161] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [132.051965] Starting subtest: basic-flip-before-cursor-legacy [133.284957] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.225s) [134.174378] [102/161] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [134.310595] Starting subtest: basic-flip-before-cursor-varying-size [135.552060] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.243s) [136.482494] [103/161] (868s left) kms_dsc (dsc-basic) [136.575638] Starting subtest: dsc-basic [136.586695] Subtest dsc-basic: SKIP (0.000s) [136.672428] [104/161] (867s left) kms_flip (basic-flip-vs-dpms) [136.775980] Starting subtest: basic-flip-vs-dpms [136.782033] Starting dynamic subtest: A-eDP1 [139.542936] Dynamic subtest A-eDP1: SUCCESS (2.765s) [139.552788] Starting dynamic subtest: B-eDP1 [141.842896] Dynamic subtest B-eDP1: SUCCESS (2.304s) [141.853646] Starting dynamic subtest: C-eDP1 [144.145877] Dynamic subtest C-eDP1: SUCCESS (2.303s) [144.159068] Starting dynamic subtest: D-eDP1 [146.449718] Dynamic subtest D-eDP1: SUCCESS (2.304s) [146.458570] Subtest basic-flip-vs-dpms: SUCCESS (9.684s) [147.335378] [105/161] (857s left) kms_flip (basic-flip-vs-modeset) [147.443171] Starting subtest: basic-flip-vs-modeset [147.451726] Starting dynamic subtest: A-eDP1 [150.228576] Dynamic subtest A-eDP1: SUCCESS (2.790s) [150.239864] Starting dynamic subtest: B-eDP1 [152.526713] Dynamic subtest B-eDP1: SUCCESS (2.303s) [152.539490] Starting dynamic subtest: C-eDP1 [154.842059] Dynamic subtest C-eDP1: SUCCESS (2.310s) [154.852066] Starting dynamic subtest: D-eDP1 [157.140466] Dynamic subtest D-eDP1: SUCCESS (2.299s) [157.146498] Subtest basic-flip-vs-modeset: SUCCESS (9.707s) [158.045332] [106/161] (846s left) kms_flip (basic-flip-vs-wf_vblank) [158.142413] Starting subtest: basic-flip-vs-wf_vblank [158.151693] Starting dynamic subtest: A-eDP1 [160.235631] Dynamic subtest A-eDP1: SUCCESS (2.102s) [160.246992] Starting dynamic subtest: B-eDP1 [162.346352] Dynamic subtest B-eDP1: SUCCESS (2.110s) [162.360299] Starting dynamic subtest: C-eDP1 [164.451856] Dynamic subtest C-eDP1: SUCCESS (2.094s) [164.462569] Starting dynamic subtest: D-eDP1 [166.493452] Dynamic subtest D-eDP1: SUCCESS (2.049s) [166.501617] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.365s) [167.774792] [107/161] (836s left) kms_flip (basic-plain-flip) [167.865568] Starting subtest: basic-plain-flip [167.871273] Starting dynamic subtest: A-eDP1 [169.681506] Dynamic subtest A-eDP1: SUCCESS (1.824s) [169.695407] Starting dynamic subtest: B-eDP1 [171.474281] Dynamic subtest B-eDP1: SUCCESS (1.791s) [171.486099] Starting dynamic subtest: C-eDP1 [173.256736] Dynamic subtest C-eDP1: SUCCESS (1.770s) [173.266450] Starting dynamic subtest: D-eDP1 [175.049356] Dynamic subtest D-eDP1: SUCCESS (1.792s) [175.055503] Subtest basic-plain-flip: SUCCESS (7.190s) [176.290172] [108/161] (828s left) kms_force_connector_basic (force-connector-state) [176.359449] Starting subtest: force-connector-state [176.909431] Subtest force-connector-state: SUCCESS (0.552s) [177.942579] [109/161] (826s left) kms_force_connector_basic (force-edid) [178.015330] Starting subtest: force-edid [178.278053] Subtest force-edid: SUCCESS (0.259s) [178.395842] [110/161] (826s left) kms_force_connector_basic (force-load-detect) [178.464033] Starting subtest: force-load-detect [178.475335] Subtest force-load-detect: SKIP (0.000s) [178.573682] [111/161] (826s left) kms_force_connector_basic (prune-stale-modes) [178.645819] Starting subtest: prune-stale-modes [178.825996] Subtest prune-stale-modes: SKIP (0.184s) [178.965715] [112/161] (825s left) kms_frontbuffer_tracking (basic) [179.073258] Starting subtest: basic [182.902042] Subtest basic: SUCCESS (3.842s) [183.005691] [113/161] (821s left) kms_hdmi_inject (inject-audio) [183.362264] Starting subtest: inject-audio [183.599568] Subtest inject-audio: SUCCESS (0.234s) [184.281301] [114/161] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [184.367607] Starting subtest: compare-crc-sanitycheck-xr24 [184.373453] Starting dynamic subtest: pipe-A-eDP-1 [185.086436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s) [185.096836] Starting dynamic subtest: pipe-B-eDP-1 [186.445890] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s) [186.457992] Starting dynamic subtest: pipe-C-eDP-1 [187.802167] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s) [187.814624] Starting dynamic subtest: pipe-D-eDP-1 [189.127895] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [189.133720] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.760s) [190.048562] [115/161] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [190.139089] Starting subtest: compare-crc-sanitycheck-nv12 [190.144795] Starting dynamic subtest: pipe-A-eDP-1 [190.923142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s) [190.934591] Starting dynamic subtest: pipe-B-eDP-1 [192.285854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s) [192.297861] Starting dynamic subtest: pipe-C-eDP-1 [193.632056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [193.644172] Starting dynamic subtest: pipe-D-eDP-1 [194.973266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s) [194.979347] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.832s) [195.872841] [116/161] (809s left) kms_pipe_crc_basic (hang-read-crc) [195.972316] Starting subtest: hang-read-crc [195.978635] Starting dynamic subtest: pipe-A-eDP-1 [198.286809] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.318s) [198.299137] Starting dynamic subtest: pipe-B-eDP-1 [201.309456] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.016s) [201.322269] Starting dynamic subtest: pipe-C-eDP-1 [204.265514] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.957s) [204.277056] Starting dynamic subtest: pipe-D-eDP-1 [207.210198] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.945s) [207.216354] Subtest hang-read-crc: SUCCESS (11.240s) [208.098221] [117/161] (796s left) kms_pipe_crc_basic (nonblocking-crc) [208.182722] Starting subtest: nonblocking-crc [208.190621] Starting dynamic subtest: pipe-A-eDP-1 [209.057379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.869s) [209.070367] Starting dynamic subtest: pipe-B-eDP-1 [210.630556] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.574s) [210.642765] Starting dynamic subtest: pipe-C-eDP-1 [212.211964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.579s) [212.224530] Starting dynamic subtest: pipe-D-eDP-1 [213.790653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.582s) [213.796545] Subtest nonblocking-crc: SUCCESS (5.608s) [214.688230] [118/161] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [214.770915] Starting subtest: nonblocking-crc-frame-sequence [214.776758] Starting dynamic subtest: pipe-A-eDP-1 [215.651130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s) [215.663051] Starting dynamic subtest: pipe-B-eDP-1 [217.234929] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.585s) [217.247638] Starting dynamic subtest: pipe-C-eDP-1 [218.802056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.566s) [218.820832] Starting dynamic subtest: pipe-D-eDP-1 [220.372354] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.567s) [220.378625] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.598s) [221.278208] [119/161] (783s left) kms_pipe_crc_basic (read-crc) [221.374715] Starting subtest: read-crc [221.383885] Starting dynamic subtest: pipe-A-eDP-1 [222.175135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.801s) [222.187195] Starting dynamic subtest: pipe-B-eDP-1 [223.697028] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.522s) [223.711369] Starting dynamic subtest: pipe-C-eDP-1 [225.198360] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s) [225.209138] Starting dynamic subtest: pipe-D-eDP-1 [226.657565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.452s) [226.663955] Subtest read-crc: SUCCESS (5.282s) [227.550463] [120/161] (777s left) kms_pipe_crc_basic (read-crc-frame-sequence) [227.633418] Starting subtest: read-crc-frame-sequence [227.641830] Starting dynamic subtest: pipe-A-eDP-1 [228.441083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s) [228.452120] Starting dynamic subtest: pipe-B-eDP-1 [229.987981] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.540s) [229.999357] Starting dynamic subtest: pipe-C-eDP-1 [231.478141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s) [231.489405] Starting dynamic subtest: pipe-D-eDP-1 [233.026085] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.551s) [233.032161] Subtest read-crc-frame-sequence: SUCCESS (5.394s) [233.948977] [121/161] (771s left) kms_pm_backlight (basic-brightness) [234.043881] Starting subtest: basic-brightness [234.110185] Starting dynamic subtest: eDP-1 [234.409259] Dynamic subtest eDP-1: SUCCESS (0.295s) [234.415862] Subtest basic-brightness: SUCCESS (0.363s) [235.292462] [122/161] (769s left) kms_pm_rpm (basic-pci-d3-state) [237.212184] Starting subtest: basic-pci-d3-state [241.422451] Subtest basic-pci-d3-state: SUCCESS (4.209s) [241.503989] [123/161] (763s left) kms_pm_rpm (basic-rte) [241.544234] Starting subtest: basic-rte [247.631372] Subtest basic-rte: SUCCESS (6.088s) [249.369917] [124/161] (755s left) kms_psr (psr-primary-page-flip) [249.458670] Starting subtest: psr-primary-page-flip [249.464801] Starting dynamic subtest: eDP-1 [251.488147] Dynamic subtest eDP-1: SUCCESS (2.025s) [251.497234] Subtest psr-primary-page-flip: SUCCESS (2.026s) [252.385115] [125/161] (752s left) kms_psr (psr-cursor-plane-move) [252.476206] Starting subtest: psr-cursor-plane-move [252.481823] Starting dynamic subtest: eDP-1 [254.468309] Dynamic subtest eDP-1: SUCCESS (1.992s) [254.473987] Subtest psr-cursor-plane-move: SUCCESS (1.993s) [255.399308] [126/161] (749s left) kms_psr (psr-sprite-plane-onoff) [255.493183] Starting subtest: psr-sprite-plane-onoff [255.499111] Starting dynamic subtest: eDP-1 [257.534350] Dynamic subtest eDP-1: SUCCESS (2.044s) [257.539903] Subtest psr-sprite-plane-onoff: SUCCESS (2.044s) [258.462155] [127/161] (746s left) kms_psr (psr-primary-mmap-gtt) [258.544167] Starting subtest: psr-primary-mmap-gtt [258.550322] Starting dynamic subtest: eDP-1 [260.259835] Dynamic subtest eDP-1: SKIP (1.703s) [260.273202] Subtest psr-primary-mmap-gtt: SKIP (1.704s) [260.411641] [128/161] (744s left) kms_setmode (basic-clone-single-crtc) [260.470340] Starting subtest: basic-clone-single-crtc [260.487455] Subtest basic-clone-single-crtc: SKIP (0.000s) [260.556389] [129/161] (744s left) i915_pm_rps (basic-api) [260.617438] Starting subtest: basic-api [260.628960] Subtest basic-api: SKIP (0.000s) [260.754238] [130/161] (744s left) prime_self_import (basic-llseek-bad) [260.791687] Starting subtest: basic-llseek-bad [260.810132] Subtest basic-llseek-bad: SUCCESS (0.023s) [260.910055] [131/161] (744s left) prime_self_import (basic-llseek-size) [260.948469] Starting subtest: basic-llseek-size [260.960721] Subtest basic-llseek-size: SUCCESS (0.012s) [261.042462] [132/161] (744s left) prime_self_import (basic-with_fd_dup) [261.083653] Starting subtest: basic-with_fd_dup [261.095047] Subtest basic-with_fd_dup: SUCCESS (0.014s) [261.172628] [133/161] (744s left) prime_self_import (basic-with_one_bo) [261.211147] Starting subtest: basic-with_one_bo [261.229052] Subtest basic-with_one_bo: SUCCESS (0.016s) [261.322816] [134/161] (743s left) prime_self_import (basic-with_one_bo_two_files) [261.362180] Starting subtest: basic-with_one_bo_two_files [261.373765] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s) [261.456875] [135/161] (743s left) prime_self_import (basic-with_two_bos) [261.491584] Starting subtest: basic-with_two_bos [261.509226] Subtest basic-with_two_bos: SUCCESS (0.020s) [261.589701] [136/161] (743s left) prime_vgem (basic-fence-flip) [261.660844] Starting subtest: basic-fence-flip [262.053317] Subtest basic-fence-flip: SUCCESS (0.394s) [262.141193] [137/161] (743s left) prime_vgem (basic-fence-mmap) [262.207141] Starting subtest: basic-fence-mmap [262.217931] Subtest basic-fence-mmap: SKIP (0.000s) [262.293331] [138/161] (743s left) prime_vgem (basic-fence-read) [262.375750] Starting subtest: basic-fence-read [262.387264] Subtest basic-fence-read: SKIP (0.004s) [262.477522] [139/161] (742s left) prime_vgem (basic-gtt) [262.547455] Starting subtest: basic-gtt [262.559771] Subtest basic-gtt: SKIP (0.000s) [262.626164] [140/161] (742s left) prime_vgem (basic-read) [262.709415] Starting subtest: basic-read [262.720773] Subtest basic-read: SKIP (0.004s) [262.822624] [141/161] (742s left) prime_vgem (basic-write) [262.899679] Starting subtest: basic-write [262.913753] Subtest basic-write: SKIP (0.003s) [263.011145] [142/161] (742s left) vgem_basic (setversion) [263.062754] Starting subtest: setversion [263.074196] Subtest setversion: SUCCESS (0.000s) [263.108085] [143/161] (742s left) vgem_basic (create) [263.160150] Starting subtest: create [263.165840] Subtest create: SUCCESS (0.000s) [263.205638] [144/161] (742s left) vgem_basic (debugfs) [263.260052] Starting subtest: debugfs [263.269161] Subtest debugfs: SUCCESS (0.000s) [263.307960] [145/161] (742s left) vgem_basic (dmabuf-export) [263.360072] Starting subtest: dmabuf-export [263.373092] Subtest dmabuf-export: SUCCESS (0.015s) [263.439936] [146/161] (742s left) vgem_basic (dmabuf-fence) [263.495543] Starting subtest: dmabuf-fence [263.503557] Subtest dmabuf-fence: SUCCESS (0.000s) [263.536539] [147/161] (742s left) vgem_basic (dmabuf-fence-before) [263.594741] Starting subtest: dmabuf-fence-before [263.600249] Subtest dmabuf-fence-before: SUCCESS (0.000s) [263.636193] [148/161] (741s left) vgem_basic (dmabuf-mmap) [263.691020] Starting subtest: dmabuf-mmap [263.696439] Subtest dmabuf-mmap: SUCCESS (0.006s) [263.737915] [149/161] (741s left) vgem_basic (mmap) [263.793883] Starting subtest: mmap [263.799640] Subtest mmap: SUCCESS (0.004s) [263.838745] [150/161] (741s left) vgem_basic (second-client) [263.891434] Starting subtest: second-client [263.924632] Subtest second-client: SUCCESS (0.033s) [263.974454] [151/161] (741s left) vgem_basic (sysfs) [264.035495] Starting subtest: sysfs [264.041113] Subtest sysfs: SUCCESS (0.000s) [264.072369] [152/161] (741s left) core_hotunplug (unbind-rebind) [264.177065] Starting subtest: unbind-rebind [268.500137] Subtest unbind-rebind: SUCCESS (4.329s) [268.531751] [153/161] (737s left) vgem_basic (unload) [268.573057] Starting subtest: unload [297.641372] Subtest unload: SUCCESS (29.065s) [297.724254] [154/161] (708s left) i915_module_load (reload) [297.773571] Starting subtest: reload [300.504829] Subtest reload: SUCCESS (2.742s) [300.528841] [155/161] (705s left) gem_lmem_swapping (basic) [300.581846] Subtest basic: SKIP (0.000s) [300.624891] [156/161] (705s left) gem_lmem_swapping (parallel-random-engines) [300.683350] Subtest parallel-random-engines: SKIP (0.000s) [300.713734] [157/161] (705s left) gem_lmem_swapping (random-engines) [300.763752] Subtest random-engines: SKIP (0.000s) [300.792250] [158/161] (705s left) gem_lmem_swapping (verify-random) [300.841995] Subtest verify-random: SKIP (0.000s) [300.868867] [159/161] (704s left) i915_pm_rpm (module-reload) [303.137184] Starting subtest: module-reload [314.214928] Subtest module-reload: SUCCESS (11.074s) [314.240117] [160/161] (691s left) i915_selftest (live) [314.290405] Starting subtest: live [314.296635] Starting dynamic subtest: sanitycheck [316.614964] Dynamic subtest sanitycheck: SUCCESS (2.317s) [316.626640] Starting dynamic subtest: uncore [318.929692] Dynamic subtest uncore: SUCCESS (2.314s) [318.941323] Starting dynamic subtest: workarounds [324.326418] Warning: kernel log ringbuffer underflow, some records lost. [386.354061] Dynamic subtest workarounds: FAIL (66.995s) [386.365492] Subtest live: FAIL (71.627s) [386.377960] Killing the test because the kernel is tainted. [386.385628] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [386.392117] Closing watchdogs