[42.169341] Initializing watchdogs [42.169406] /dev/watchdog0 [42.176497] [001/171] (960s left) i915_module_load (load) [42.244142] Starting subtest: load [43.374402] Subtest load: SUCCESS (1.128s) [43.401203] [002/171] (959s left) core_auth (basic-auth) [43.495291] Starting subtest: basic-auth [43.498328] Subtest basic-auth: SUCCESS (0.000s) [43.554486] [003/171] (959s left) debugfs_test (read_all_entries) [43.617460] Starting subtest: read_all_entries [43.741378] Subtest read_all_entries: SUCCESS (0.123s) [43.854457] [004/171] (958s left) debugfs_test (basic-hwmon) [43.926552] Starting subtest: basic-hwmon [43.933422] Subtest basic-hwmon: SKIP (0.000s) [44.037826] [005/171] (958s left) fbdev (eof) [44.105431] Starting subtest: eof [44.109215] Subtest eof: SUCCESS (0.000s) [44.154705] [006/171] (958s left) fbdev (info) [44.235094] Starting subtest: info [44.238224] Subtest info: SUCCESS (0.000s) [44.303415] [007/171] (958s left) fbdev (nullptr) [44.405803] Starting subtest: nullptr [44.409229] Subtest nullptr: SUCCESS (0.000s) [44.451626] [008/171] (958s left) fbdev (read) [44.521614] Starting subtest: read [44.736229] Subtest read: SUCCESS (0.215s) [44.784728] [009/171] (958s left) fbdev (write) [44.854857] Starting subtest: write [44.965204] Subtest write: SUCCESS (0.110s) [45.001560] [010/171] (957s left) gem_basic (bad-close) [45.061070] Starting subtest: bad-close [45.067457] Subtest bad-close: SUCCESS (0.000s) [45.123093] [011/171] (957s left) gem_basic (create-close) [45.182751] Starting subtest: create-close [45.191293] Subtest create-close: SUCCESS (0.000s) [45.283769] [012/171] (957s left) gem_basic (create-fd-close) [45.393011] Starting subtest: create-fd-close [45.399927] Subtest create-fd-close: SUCCESS (0.000s) [45.480671] [013/171] (957s left) gem_busy (busy@all-engines) [45.592807] Starting subtest: busy [45.596050] Starting dynamic subtest: all-engines [45.614165] Dynamic subtest all-engines: SUCCESS (0.022s) [45.617595] Subtest busy: SUCCESS (0.022s) [45.963646] [014/171] (957s left) gem_close_race (basic-process) [46.027546] Starting subtest: basic-process [46.071494] Subtest basic-process: SUCCESS (0.044s) [46.263987] [015/171] (956s left) gem_close_race (basic-threads) [46.341065] Starting subtest: basic-threads [47.558015] Subtest basic-threads: SUCCESS (1.217s) [47.772538] [016/171] (955s left) gem_ctx_create (basic) [47.852572] Starting subtest: basic [47.856047] Subtest basic: SUCCESS (0.000s) [48.040045] [017/171] (955s left) gem_ctx_create (basic-files) [48.156977] Starting subtest: basic-files [50.173205] Subtest basic-files: SUCCESS (2.017s) [50.563424] [018/171] (952s left) gem_ctx_exec (basic) [51.057689] Starting subtest: basic [51.123734] Subtest basic: SUCCESS (0.002s) [51.354202] [019/171] (952s left) gem_exec_basic (basic) [51.738859] Starting subtest: basic [51.742370] Starting dynamic subtest: rcs0-smem [51.745797] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [51.756173] Starting dynamic subtest: bcs0-smem [51.759562] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [51.766357] Starting dynamic subtest: vcs0-smem [51.769521] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [51.776812] Starting dynamic subtest: vecs0-smem [51.780055] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [51.783258] Subtest basic: SUCCESS (0.002s) [51.802682] [020/171] (951s left) gem_exec_create (basic) [51.899066] Starting subtest: basic [51.902180] Starting dynamic subtest: smem [53.934143] Dynamic subtest smem: SUCCESS (2.034s) [53.937826] Subtest basic: SUCCESS (2.035s) [54.152502] [021/171] (949s left) gem_exec_fence (basic-busy) [54.373075] Starting subtest: basic-busy [54.376118] Starting dynamic subtest: rcs0 [54.395022] Dynamic subtest rcs0: SUCCESS (0.022s) [54.404138] Starting dynamic subtest: bcs0 [54.434519] Dynamic subtest bcs0: SUCCESS (0.038s) [54.442797] Starting dynamic subtest: vcs0 [54.466035] Dynamic subtest vcs0: SUCCESS (0.032s) [54.475301] Starting dynamic subtest: vecs0 [54.494553] Dynamic subtest vecs0: SUCCESS (0.028s) [54.498195] Subtest basic-busy: SUCCESS (0.121s) [55.038201] [022/171] (948s left) gem_exec_fence (basic-wait) [55.276743] Starting subtest: basic-wait [55.281222] Starting dynamic subtest: rcs0 [55.321543] Dynamic subtest rcs0: SUCCESS (0.045s) [55.332771] Starting dynamic subtest: bcs0 [55.357155] Dynamic subtest bcs0: SUCCESS (0.036s) [55.364994] Starting dynamic subtest: vcs0 [55.395809] Dynamic subtest vcs0: SUCCESS (0.038s) [55.417758] Starting dynamic subtest: vecs0 [55.426513] Dynamic subtest vecs0: SUCCESS (0.026s) [55.430600] Subtest basic-wait: SUCCESS (0.146s) [55.921519] [023/171] (947s left) gem_exec_fence (basic-await) [56.108032] Starting subtest: basic-await [56.111263] Starting dynamic subtest: rcs0 [56.178846] Dynamic subtest rcs0: SUCCESS (0.070s) [56.192884] Starting dynamic subtest: bcs0 [56.264591] Dynamic subtest bcs0: SUCCESS (0.086s) [56.274513] Starting dynamic subtest: vcs0 [56.340357] Dynamic subtest vcs0: SUCCESS (0.076s) [56.350383] Starting dynamic subtest: vecs0 [56.422541] Dynamic subtest vecs0: SUCCESS (0.081s) [56.426701] Subtest basic-await: SUCCESS (0.314s) [56.963595] [024/171] (946s left) gem_exec_fence (nb-await) [57.178550] Starting subtest: nb-await [57.182884] Starting dynamic subtest: rcs0 [57.252307] Dynamic subtest rcs0: SUCCESS (0.074s) [57.276180] Starting dynamic subtest: bcs0 [57.324160] Dynamic subtest bcs0: SUCCESS (0.071s) [57.347803] Starting dynamic subtest: vcs0 [57.394957] Dynamic subtest vcs0: SUCCESS (0.070s) [57.419337] Starting dynamic subtest: vecs0 [57.466801] Dynamic subtest vecs0: SUCCESS (0.071s) [57.471097] Subtest nb-await: SUCCESS (0.288s) [57.979733] [025/171] (945s left) gem_exec_gttfill (basic) [58.060862] Starting subtest: basic [62.756162] Subtest basic: SUCCESS (4.696s) [62.918394] [026/171] (940s left) gem_exec_parallel (engines) [63.046410] Starting subtest: engines [63.049693] Starting dynamic subtest: basic [64.472843] Dynamic subtest basic: SUCCESS (1.429s) [64.480768] Starting dynamic subtest: contexts [66.913640] Dynamic subtest contexts: SUCCESS (2.431s) [66.921244] Starting dynamic subtest: fds [69.063015] Dynamic subtest fds: SUCCESS (2.159s) [69.070540] Starting dynamic subtest: userptr [70.798696] Dynamic subtest userptr: SUCCESS (1.735s) [70.801870] Subtest engines: SUCCESS (7.754s) [70.963650] [027/171] (932s left) gem_exec_store (basic) [71.041668] Starting subtest: basic [71.084219] Subtest basic: SUCCESS (0.050s) [71.253250] [028/171] (932s left) gem_flink_basic (bad-flink) [71.321294] Starting subtest: bad-flink [71.324551] Subtest bad-flink: SUCCESS (0.000s) [71.371405] [029/171] (932s left) gem_flink_basic (bad-open) [71.447316] Starting subtest: bad-open [71.450605] Subtest bad-open: SUCCESS (0.000s) [71.511153] [030/171] (932s left) gem_flink_basic (basic) [71.612737] Starting subtest: basic [71.616158] Subtest basic: SUCCESS (0.000s) [71.696773] [031/171] (932s left) gem_flink_basic (double-flink) [71.767829] Starting subtest: double-flink [71.770856] Subtest double-flink: SUCCESS (0.000s) [71.847191] [032/171] (931s left) gem_flink_basic (flink-lifetime) [71.911385] Starting subtest: flink-lifetime [71.914383] Subtest flink-lifetime: SUCCESS (0.001s) [72.049463] [033/171] (931s left) gem_huc_copy (huc-copy) [72.150564] Starting subtest: huc-copy [72.153764] Subtest huc-copy: SUCCESS (0.004s) [72.282203] [034/171] (931s left) gem_linear_blits (basic) [72.449937] Starting subtest: basic [72.456929] Subtest basic: SUCCESS (0.004s) [72.606513] [035/171] (931s left) gem_mmap (basic) [72.775928] Starting subtest: basic [72.792626] Subtest basic: SUCCESS (0.001s) [72.869922] [036/171] (931s left) gem_mmap_gtt (basic) [72.966696] Starting subtest: basic [72.969708] Subtest basic: SUCCESS (0.000s) [73.014669] [037/171] (930s left) gem_render_linear_blits (basic) [73.086602] Starting subtest: basic [73.106066] Subtest basic: SUCCESS (0.018s) [73.148776] [038/171] (930s left) gem_render_tiled_blits (basic) [73.223725] Starting subtest: basic [73.256146] Subtest basic: SUCCESS (0.036s) [73.298561] [039/171] (930s left) gem_ringfill (basic-all) [73.584763] Starting subtest: basic-all [74.724373] Subtest basic-all: SUCCESS (1.145s) [74.844813] [040/171] (929s left) gem_softpin (allocator-basic) [74.908546] Starting subtest: allocator-basic [74.967129] Subtest allocator-basic: SUCCESS (0.061s) [75.064321] [041/171] (928s left) gem_softpin (allocator-basic-reserve) [75.133916] Starting subtest: allocator-basic-reserve [75.189941] Subtest allocator-basic-reserve: SUCCESS (0.057s) [75.291535] [042/171] (928s left) gem_softpin (safe-alignment) [75.379173] Starting subtest: safe-alignment [75.386067] Subtest safe-alignment: SUCCESS (0.006s) [75.516360] [043/171] (928s left) gem_sync (basic-all) [75.618367] Starting subtest: basic-all [77.799933] Subtest basic-all: SUCCESS (2.206s) [77.995234] [044/171] (926s left) gem_sync (basic-each) [78.089926] Starting subtest: basic-each [80.161518] Subtest basic-each: SUCCESS (2.094s) [80.383727] [045/171] (923s left) gem_tiled_blits (basic) [80.518413] Starting subtest: basic [80.528049] Subtest basic: SUCCESS (0.010s) [80.697744] [046/171] (923s left) gem_tiled_fence_blits (basic) [80.926402] Starting subtest: basic [80.933633] Subtest basic: SUCCESS (0.008s) [81.077680] [047/171] (923s left) gem_tiled_pread_basic [81.477745] [048/171] (922s left) gem_wait (busy@all-engines) [81.544526] Starting subtest: busy [81.547594] Starting dynamic subtest: all-engines [82.058376] Dynamic subtest all-engines: SUCCESS (0.514s) [82.061788] Subtest busy: SUCCESS (0.514s) [82.256243] [049/171] (922s left) gem_wait (wait@all-engines) [82.320759] Starting subtest: wait [82.324077] Starting dynamic subtest: all-engines [83.361697] Dynamic subtest all-engines: SUCCESS (1.040s) [83.365902] Subtest wait: SUCCESS (1.040s) [83.544505] [050/171] (920s left) i915_getparams_basic (basic-eu-total) [83.609511] Starting subtest: basic-eu-total [83.616463] Subtest basic-eu-total: SUCCESS (0.000s) [83.677237] [051/171] (920s left) i915_getparams_basic (basic-subslice-total) [83.773307] Starting subtest: basic-subslice-total [83.780170] Subtest basic-subslice-total: SUCCESS (0.000s) [83.821117] [052/171] (920s left) i915_hangman (error-state-basic) [83.889898] Starting subtest: error-state-basic [83.945831] Subtest error-state-basic: SUCCESS (0.055s) [84.032202] [053/171] (920s left) i915_pciid [84.191174] [054/171] (920s left) kms_addfb_basic (addfb25-bad-modifier) [84.282391] Starting subtest: addfb25-bad-modifier [84.286745] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [84.419184] [055/171] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [84.480494] Starting subtest: addfb25-framebuffer-vs-set-tiling [84.483629] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.619267] [056/171] (919s left) kms_addfb_basic (addfb25-modifier-no-flag) [84.682610] Starting subtest: addfb25-modifier-no-flag [84.686198] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [84.804941] [057/171] (919s left) kms_addfb_basic (addfb25-x-tiled-legacy) [84.867319] Starting subtest: addfb25-x-tiled-legacy [84.870411] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [84.985421] [058/171] (919s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [85.045208] Starting subtest: addfb25-x-tiled-mismatch-legacy [85.048012] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [85.168985] [059/171] (919s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [85.276035] Starting subtest: addfb25-yf-tiled-legacy [85.278846] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [85.358245] [060/171] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy) [85.475717] Starting subtest: addfb25-y-tiled-legacy [85.478398] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [85.538863] [061/171] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [85.645901] Starting subtest: addfb25-y-tiled-small-legacy [85.648939] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [85.736512] [062/171] (918s left) kms_addfb_basic (bad-pitch-0) [85.799574] Starting subtest: bad-pitch-0 [85.802594] Subtest bad-pitch-0: SUCCESS (0.000s) [85.919485] [063/171] (918s left) kms_addfb_basic (bad-pitch-1024) [85.981155] Starting subtest: bad-pitch-1024 [85.984226] Subtest bad-pitch-1024: SUCCESS (0.000s) [86.102608] [064/171] (918s left) kms_addfb_basic (bad-pitch-128) [86.173989] Starting subtest: bad-pitch-128 [86.177310] Subtest bad-pitch-128: SUCCESS (0.000s) [86.302720] [065/171] (918s left) kms_addfb_basic (bad-pitch-256) [86.367386] Starting subtest: bad-pitch-256 [86.371047] Subtest bad-pitch-256: SUCCESS (0.000s) [86.503630] [066/171] (918s left) kms_addfb_basic (bad-pitch-32) [86.566044] Starting subtest: bad-pitch-32 [86.569193] Subtest bad-pitch-32: SUCCESS (0.000s) [86.685929] [067/171] (918s left) kms_addfb_basic (bad-pitch-63) [86.747507] Starting subtest: bad-pitch-63 [86.750627] Subtest bad-pitch-63: SUCCESS (0.000s) [86.886531] [068/171] (917s left) kms_addfb_basic (bad-pitch-65536) [86.953800] Starting subtest: bad-pitch-65536 [86.957779] Subtest bad-pitch-65536: SUCCESS (0.001s) [87.094862] [069/171] (917s left) kms_addfb_basic (bad-pitch-999) [87.156206] Starting subtest: bad-pitch-999 [87.159470] Subtest bad-pitch-999: SUCCESS (0.000s) [87.272392] [070/171] (917s left) kms_addfb_basic (basic) [87.332295] Starting subtest: basic [87.335299] Subtest basic: SUCCESS (0.000s) [87.453236] [071/171] (917s left) kms_addfb_basic (basic-x-tiled-legacy) [87.514286] Starting subtest: basic-x-tiled-legacy [87.517356] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [87.636072] [072/171] (917s left) kms_addfb_basic (basic-y-tiled-legacy) [87.696978] Starting subtest: basic-y-tiled-legacy [87.700027] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [87.821852] [073/171] (916s left) kms_addfb_basic (bo-too-small) [87.928634] Starting subtest: bo-too-small [87.931770] Subtest bo-too-small: SUCCESS (0.000s) [88.024253] [074/171] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling) [88.151711] Starting subtest: bo-too-small-due-to-tiling [88.154762] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [88.236088] [075/171] (916s left) kms_addfb_basic (clobberred-modifier) [88.297686] Starting subtest: clobberred-modifier [88.300763] Subtest clobberred-modifier: SUCCESS (0.000s) [88.419419] [076/171] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [88.487130] Starting subtest: framebuffer-vs-set-tiling [88.490451] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [88.619612] [077/171] (916s left) kms_addfb_basic (invalid-get-prop) [88.680153] Starting subtest: invalid-get-prop [88.683204] Subtest invalid-get-prop: SUCCESS (0.000s) [88.802676] [078/171] (916s left) kms_addfb_basic (invalid-get-prop-any) [88.863683] Starting subtest: invalid-get-prop-any [88.866858] Subtest invalid-get-prop-any: SUCCESS (0.000s) [88.985780] [079/171] (915s left) kms_addfb_basic (invalid-set-prop) [89.049999] Starting subtest: invalid-set-prop [89.053619] Subtest invalid-set-prop: SUCCESS (0.000s) [89.186250] [080/171] (915s left) kms_addfb_basic (invalid-set-prop-any) [89.251100] Starting subtest: invalid-set-prop-any [89.254223] Subtest invalid-set-prop-any: SUCCESS (0.000s) [89.370446] [081/171] (915s left) kms_addfb_basic (no-handle) [89.434500] Starting subtest: no-handle [89.438026] Subtest no-handle: SUCCESS (0.000s) [89.569265] [082/171] (915s left) kms_addfb_basic (size-max) [89.674214] Starting subtest: size-max [89.676950] Subtest size-max: SUCCESS (0.000s) [89.752653] [083/171] (915s left) kms_addfb_basic (small-bo) [89.861914] Starting subtest: small-bo [89.864717] Subtest small-bo: SUCCESS (0.000s) [89.935658] [084/171] (915s left) kms_addfb_basic (tile-pitch-mismatch) [89.995985] Starting subtest: tile-pitch-mismatch [89.998878] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [90.130775] [085/171] (914s left) kms_addfb_basic (too-high) [90.288378] Starting subtest: too-high [90.291819] Subtest too-high: SUCCESS (0.000s) [90.369782] [086/171] (914s left) kms_addfb_basic (too-wide) [90.476812] Starting subtest: too-wide [90.480141] Subtest too-wide: SUCCESS (0.000s) [90.552621] [087/171] (914s left) kms_addfb_basic (unused-handle) [90.614442] Starting subtest: unused-handle [90.617823] Subtest unused-handle: SUCCESS (0.000s) [90.736117] [088/171] (914s left) kms_addfb_basic (unused-modifier) [90.796548] Starting subtest: unused-modifier [90.799733] Subtest unused-modifier: SUCCESS (0.000s) [90.918865] [089/171] (914s left) kms_addfb_basic (unused-offsets) [90.980522] Starting subtest: unused-offsets [90.983740] Subtest unused-offsets: SUCCESS (0.000s) [91.119257] [090/171] (913s left) kms_addfb_basic (unused-pitches) [91.181179] Starting subtest: unused-pitches [91.184440] Subtest unused-pitches: SUCCESS (0.000s) [91.288201] [091/171] (913s left) kms_busy (basic) [91.398200] Starting subtest: basic [91.401128] Starting dynamic subtest: flip [92.060344] Dynamic subtest flip: SUCCESS (0.662s) [92.068426] Starting dynamic subtest: modeset [92.637388] Dynamic subtest modeset: SUCCESS (0.577s) [92.640273] Subtest basic: SUCCESS (1.240s) [92.773226] [092/171] (912s left) kms_chamelium_hpd (dp-hpd-fast) [92.945845] Subtest dp-hpd-fast: SKIP (0.000s) [93.017200] [093/171] (912s left) kms_chamelium_edid (dp-edid-read) [93.173957] Subtest dp-edid-read: SKIP (0.000s) [93.242220] [094/171] (911s left) kms_chamelium_frames (dp-crc-fast) [93.403583] Subtest dp-crc-fast: SKIP (0.000s) [93.473809] [095/171] (911s left) kms_chamelium_hpd (hdmi-hpd-fast) [93.632980] Subtest hdmi-hpd-fast: SKIP (0.000s) [93.702969] [096/171] (911s left) kms_chamelium_edid (hdmi-edid-read) [93.859064] Subtest hdmi-edid-read: SKIP (0.000s) [93.926247] [097/171] (911s left) kms_chamelium_frames (hdmi-crc-fast) [94.085823] Subtest hdmi-crc-fast: SKIP (0.000s) [94.153691] [098/171] (911s left) kms_chamelium_hpd (vga-hpd-fast) [94.314701] Subtest vga-hpd-fast: SKIP (0.000s) [94.382926] [099/171] (910s left) kms_chamelium_edid (vga-edid-read) [94.542860] Subtest vga-edid-read: SKIP (0.000s) [94.611159] [100/171] (910s left) kms_prop_blob (basic) [94.673033] Starting subtest: basic [94.675653] Subtest basic: SUCCESS (0.000s) [94.727348] [101/171] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [94.833013] Starting subtest: basic-busy-flip-before-cursor-atomic [94.838678] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [94.894170] [102/171] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [94.999755] Starting subtest: basic-busy-flip-before-cursor-legacy [95.005263] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [95.060839] [103/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [95.171425] Starting subtest: basic-flip-after-cursor-atomic [96.189610] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.945s) [96.485730] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [96.803892] Starting subtest: basic-flip-after-cursor-legacy [97.745493] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.942s) [97.866054] [105/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [97.971457] Starting subtest: basic-flip-after-cursor-varying-size [98.936550] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.965s) [99.057785] [106/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [99.163127] Starting subtest: basic-flip-before-cursor-atomic [100.112872] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.950s) [100.238571] [107/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [100.344893] Starting subtest: basic-flip-before-cursor-legacy [101.309052] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.964s) [101.441374] [108/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [101.548355] Starting subtest: basic-flip-before-cursor-varying-size [102.494256] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s) [102.623497] [109/171] (903s left) kms_flip (basic-flip-vs-dpms) [102.722840] Starting subtest: basic-flip-vs-dpms [102.725923] Starting dynamic subtest: A-HDMI-A1 [103.678601] Dynamic subtest A-HDMI-A1: SUCCESS (0.956s) [103.686443] Starting dynamic subtest: B-HDMI-A1 [104.582039] Dynamic subtest B-HDMI-A1: SUCCESS (0.902s) [104.589908] Starting dynamic subtest: C-HDMI-A1 [105.480860] Dynamic subtest C-HDMI-A1: SUCCESS (0.900s) [105.483577] Subtest basic-flip-vs-dpms: SUCCESS (2.762s) [105.608982] [110/171] (900s left) kms_flip (basic-flip-vs-modeset) [105.710666] Starting subtest: basic-flip-vs-modeset [105.713652] Starting dynamic subtest: A-HDMI-A1 [106.588931] Dynamic subtest A-HDMI-A1: SUCCESS (0.878s) [106.596969] Starting dynamic subtest: B-HDMI-A1 [107.388996] Dynamic subtest B-HDMI-A1: SUCCESS (0.800s) [107.396795] Starting dynamic subtest: C-HDMI-A1 [108.187984] Dynamic subtest C-HDMI-A1: SUCCESS (0.798s) [108.190689] Subtest basic-flip-vs-modeset: SUCCESS (2.481s) [108.332504] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank) [108.435134] Starting subtest: basic-flip-vs-wf_vblank [108.437860] Starting dynamic subtest: A-HDMI-A1 [109.688415] Dynamic subtest A-HDMI-A1: SUCCESS (1.159s) [109.753705] Starting dynamic subtest: B-HDMI-A1 [110.717348] Dynamic subtest B-HDMI-A1: SUCCESS (1.125s) [110.725195] Starting dynamic subtest: C-HDMI-A1 [111.848368] Dynamic subtest C-HDMI-A1: SUCCESS (1.125s) [111.851460] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.419s) [112.031623] [112/171] (893s left) kms_flip (basic-plain-flip) [112.142276] Starting subtest: basic-plain-flip [112.145480] Starting dynamic subtest: A-HDMI-A1 [113.023802] Dynamic subtest A-HDMI-A1: SUCCESS (0.878s) [113.031632] Starting dynamic subtest: B-HDMI-A1 [113.863936] Dynamic subtest B-HDMI-A1: SUCCESS (0.843s) [113.872291] Starting dynamic subtest: C-HDMI-A1 [114.723779] Dynamic subtest C-HDMI-A1: SUCCESS (0.857s) [114.726965] Subtest basic-plain-flip: SUCCESS (2.584s) [114.893408] [113/171] (890s left) kms_force_connector_basic (force-connector-state) [115.061688] Starting subtest: force-connector-state [115.449772] Subtest force-connector-state: SUCCESS (0.387s) [115.860788] [114/171] (889s left) kms_force_connector_basic (force-edid) [116.018698] Starting subtest: force-edid [116.159148] Subtest force-edid: SUCCESS (0.140s) [116.360958] [115/171] (889s left) kms_force_connector_basic (force-load-detect) [116.520891] Starting subtest: force-load-detect [116.527141] Subtest force-load-detect: SKIP (0.000s) [116.727494] [116/171] (889s left) kms_force_connector_basic (prune-stale-modes) [116.884725] Starting subtest: prune-stale-modes [117.020604] Subtest prune-stale-modes: SUCCESS (0.136s) [117.227485] [117/171] (888s left) kms_frontbuffer_tracking (basic) [117.347557] Starting subtest: basic [119.726376] Subtest basic: SUCCESS (2.390s) [119.853179] [118/171] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [119.979225] Starting subtest: compare-crc-sanitycheck-xr24 [119.982295] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.333263] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.354s) [120.341308] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.736886] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.402s) [120.745155] Starting dynamic subtest: pipe-C-HDMI-A-1 [121.140508] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.403s) [121.143588] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.163s) [121.260359] [119/171] (884s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [121.368051] Starting subtest: compare-crc-sanitycheck-nv12 [121.371031] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.780550] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.412s) [121.788404] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.207739] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.426s) [122.215721] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.221540] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [122.224622] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.842s) [122.339298] [120/171] (883s left) kms_pipe_crc_basic (hang-read-crc) [122.447494] Starting subtest: hang-read-crc [122.450168] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.399591] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.953s) [123.408141] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.484357] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.968s) [124.549512] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.590459] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.036s) [125.594102] Subtest hang-read-crc: SUCCESS (2.960s) [125.613368] [121/171] (880s left) kms_pipe_crc_basic (nonblocking-crc) [126.016801] Starting subtest: nonblocking-crc [126.091163] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.567317] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s) [126.635677] Starting dynamic subtest: pipe-B-HDMI-A-1 [127.044419] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.529s) [127.195312] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.561497] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.581s) [127.564635] Subtest nonblocking-crc: SUCCESS (1.639s) [127.663208] [122/171] (878s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [127.772294] Starting subtest: nonblocking-crc-frame-sequence [127.775461] Starting dynamic subtest: pipe-A-HDMI-A-1 [128.316976] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.544s) [128.326186] Starting dynamic subtest: pipe-B-HDMI-A-1 [128.846071] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.528s) [128.854848] Starting dynamic subtest: pipe-C-HDMI-A-1 [129.412044] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.565s) [129.415243] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.641s) [129.516560] [123/171] (876s left) kms_pipe_crc_basic (read-crc) [129.624701] Starting subtest: read-crc [129.627878] Starting dynamic subtest: pipe-A-HDMI-A-1 [130.086722] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.460s) [130.095385] Starting dynamic subtest: pipe-B-HDMI-A-1 [130.549893] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.462s) [130.558497] Starting dynamic subtest: pipe-C-HDMI-A-1 [131.047859] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.497s) [131.050945] Subtest read-crc: SUCCESS (1.423s) [131.149445] [124/171] (874s left) kms_pipe_crc_basic (read-crc-frame-sequence) [131.258226] Starting subtest: read-crc-frame-sequence [131.261086] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.704650] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.445s) [131.716416] Starting dynamic subtest: pipe-B-HDMI-A-1 [132.201613] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.497s) [132.210045] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.699163] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.496s) [132.702484] Subtest read-crc-frame-sequence: SUCCESS (1.442s) [132.803335] [125/171] (873s left) kms_psr (primary_page_flip) [132.872197] Subtest primary_page_flip: SKIP (0.000s) [132.896547] [126/171] (873s left) kms_psr (cursor_plane_move) [132.963066] Subtest cursor_plane_move: SKIP (0.000s) [132.999853] [127/171] (873s left) kms_psr (sprite_plane_onoff) [133.079122] Subtest sprite_plane_onoff: SKIP (0.000s) [133.096675] [128/171] (872s left) kms_psr (primary_mmap_gtt) [133.165426] Subtest primary_mmap_gtt: SKIP (0.000s) [133.183357] [129/171] (872s left) kms_setmode (basic-clone-single-crtc) [133.255100] Starting subtest: basic-clone-single-crtc [133.265612] Subtest basic-clone-single-crtc: SKIP (0.000s) [133.302220] [130/171] (872s left) i915_pm_backlight (basic-brightness) [133.438407] Subtest basic-brightness: SKIP (0.000s) [133.464207] [131/171] (872s left) i915_pm_rpm (basic-pci-d3-state) [134.993236] Starting subtest: basic-pci-d3-state [145.834066] Subtest basic-pci-d3-state: FAIL (10.771s) [146.305915] [132/171] (860s left) i915_pm_rpm (basic-rte) [146.602183] Starting subtest: basic-rte [158.837125] Subtest basic-rte: FAIL (12.102s) [169.835497] [133/171] (836s left) i915_pm_rps (basic-api) [170.329814] Starting subtest: basic-api [170.395698] Subtest basic-api: SUCCESS (0.002s) [170.691954] [134/171] (836s left) prime_self_import (basic-llseek-bad) [170.934335] Starting subtest: basic-llseek-bad [170.941322] Subtest basic-llseek-bad: SUCCESS (0.001s) [171.060053] [135/171] (835s left) prime_self_import (basic-llseek-size) [171.127643] Starting subtest: basic-llseek-size [171.134470] Subtest basic-llseek-size: SUCCESS (0.001s) [171.204880] [136/171] (835s left) prime_self_import (basic-with_fd_dup) [171.295279] Starting subtest: basic-with_fd_dup [171.302194] Subtest basic-with_fd_dup: SUCCESS (0.002s) [171.418846] [137/171] (835s left) prime_self_import (basic-with_one_bo) [171.510875] Starting subtest: basic-with_one_bo [171.518260] Subtest basic-with_one_bo: SUCCESS (0.002s) [171.556781] [138/171] (835s left) prime_self_import (basic-with_one_bo_two_files) [171.619889] Starting subtest: basic-with_one_bo_two_files [171.627629] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s) [171.724714] [139/171] (835s left) prime_self_import (basic-with_two_bos) [171.784214] Starting subtest: basic-with_two_bos [171.790917] Subtest basic-with_two_bos: SUCCESS (0.002s) [171.878961] [140/171] (835s left) prime_vgem (basic-fence-flip) [171.976372] Starting subtest: basic-fence-flip [172.395419] Subtest basic-fence-flip: SUCCESS (0.422s) [172.481844] [141/171] (834s left) prime_vgem (basic-fence-mmap) [172.577619] Starting subtest: basic-fence-mmap [172.593560] Subtest basic-fence-mmap: SUCCESS (0.017s) [172.710996] [142/171] (834s left) prime_vgem (basic-fence-read) [172.788281] Starting subtest: basic-fence-read [172.807459] Subtest basic-fence-read: SUCCESS (0.025s) [172.899504] [143/171] (834s left) prime_vgem (basic-gtt) [173.003269] Starting subtest: basic-gtt [173.006183] Subtest basic-gtt: SUCCESS (0.007s) [173.107219] [144/171] (834s left) prime_vgem (basic-read) [173.198402] Starting subtest: basic-read [173.207791] Subtest basic-read: SUCCESS (0.011s) [173.344503] [145/171] (833s left) prime_vgem (basic-write) [173.451979] Starting subtest: basic-write [173.461228] Subtest basic-write: SUCCESS (0.012s) [173.595082] [146/171] (833s left) vgem_basic (setversion) [173.698697] Starting subtest: setversion [173.705638] Subtest setversion: SUCCESS (0.000s) [173.776084] [147/171] (833s left) vgem_basic (create) [173.849896] Starting subtest: create [173.853210] Subtest create: SUCCESS (0.000s) [173.895522] [148/171] (833s left) vgem_basic (debugfs) [173.965076] Starting subtest: debugfs [173.968434] Subtest debugfs: SUCCESS (0.000s) [174.013507] [149/171] (833s left) vgem_basic (dmabuf-export) [174.098730] Starting subtest: dmabuf-export [174.107881] Subtest dmabuf-export: SUCCESS (0.011s) [174.210052] [150/171] (833s left) vgem_basic (dmabuf-fence) [174.286832] Starting subtest: dmabuf-fence [174.291346] Subtest dmabuf-fence: SUCCESS (0.002s) [174.359576] [151/171] (833s left) vgem_basic (dmabuf-fence-before) [174.465373] Starting subtest: dmabuf-fence-before [174.468715] Subtest dmabuf-fence-before: SUCCESS (0.000s) [174.515276] [152/171] (832s left) vgem_basic (dmabuf-mmap) [174.584210] Starting subtest: dmabuf-mmap [174.591177] Subtest dmabuf-mmap: SUCCESS (0.008s) [174.632469] [153/171] (832s left) vgem_basic (mmap) [174.715561] Starting subtest: mmap [174.718418] Subtest mmap: SUCCESS (0.005s) [174.760841] [154/171] (832s left) vgem_basic (second-client) [174.832139] Starting subtest: second-client [174.865490] Subtest second-client: SUCCESS (0.033s) [174.946598] [155/171] (832s left) vgem_basic (sysfs) [175.032678] Starting subtest: sysfs [175.035958] Subtest sysfs: SUCCESS (0.000s) [175.078161] [156/171] (832s left) core_hotunplug (unbind-rebind) [175.179184] Starting subtest: unbind-rebind [176.250620] Subtest unbind-rebind: SUCCESS (1.072s) [176.270824] [157/171] (831s left) vgem_basic (unload) [176.335313] Starting subtest: unload [205.258185] Subtest unload: SUCCESS (28.925s) [205.363286] [158/171] (802s left) i915_module_load (reload) [205.428964] Starting subtest: reload [208.089416] Subtest reload: SUCCESS (2.664s) [208.118680] [159/171] (799s left) gem_lmem_swapping (basic) [208.199107] Subtest basic: SKIP (0.000s) [208.220532] [160/171] (799s left) gem_lmem_swapping (parallel-random-engines) [208.286861] Subtest parallel-random-engines: SKIP (0.000s) [208.307614] [161/171] (799s left) gem_lmem_swapping (random-engines) [208.375443] Subtest random-engines: SKIP (0.000s) [208.408759] [162/171] (799s left) gem_lmem_swapping (verify-random) [208.485666] Subtest verify-random: SKIP (0.000s) [208.505243] [163/171] (799s left) i915_pm_rpm (module-reload) [210.394883] Starting subtest: module-reload [226.528096] Subtest module-reload: FAIL (15.793s) [226.549686] [164/171] (781s left) i915_selftest (live) [227.530789] Starting subtest: live [227.601164] Starting dynamic subtest: sanitycheck [228.051842] Dynamic subtest sanitycheck: SUCCESS (0.528s) [228.121258] Starting dynamic subtest: uncore [228.529388] Dynamic subtest uncore: SUCCESS (0.527s) [228.536698] Starting dynamic subtest: workarounds [229.262615] Dynamic subtest workarounds: SUCCESS (0.732s) [229.270938] Starting dynamic subtest: gt_engines [230.261563] Dynamic subtest gt_engines: SUCCESS (0.998s) [230.269116] Starting dynamic subtest: gt_timelines [236.256698] Dynamic subtest gt_timelines: SUCCESS (5.994s) [236.264267] Starting dynamic subtest: gt_contexts [236.943522] Dynamic subtest gt_contexts: SUCCESS (0.686s) [236.950985] Starting dynamic subtest: gt_lrc [239.781552] Dynamic subtest gt_lrc: SUCCESS (2.837s) [239.789529] Starting dynamic subtest: gt_mocs [240.403742] Dynamic subtest gt_mocs: SUCCESS (0.621s) [240.411776] Starting dynamic subtest: gt_pm [242.836516] Dynamic subtest gt_pm: SUCCESS (2.432s) [242.843720] Starting dynamic subtest: gt_heartbeat [243.478538] Dynamic subtest gt_heartbeat: SUCCESS (0.641s) [243.486045] Starting dynamic subtest: gt_tlb [244.869552] Dynamic subtest gt_tlb: SUCCESS (1.390s) [244.878947] Starting dynamic subtest: requests [251.655777] Dynamic subtest requests: SUCCESS (6.785s) [251.662847] Starting dynamic subtest: migrate [255.138568] Dynamic subtest migrate: SUCCESS (3.482s) [255.146088] Starting dynamic subtest: active [255.648442] Dynamic subtest active: SUCCESS (0.509s) [255.655413] Starting dynamic subtest: objects [256.745502] Dynamic subtest objects: SUCCESS (1.096s) [256.752958] Starting dynamic subtest: mman [260.549643] Dynamic subtest mman: SUCCESS (3.803s) [260.557033] Starting dynamic subtest: dmabuf [261.170672] Dynamic subtest dmabuf: SUCCESS (0.620s) [261.178193] Starting dynamic subtest: vma [261.704455] Dynamic subtest vma: SUCCESS (0.533s) [261.711608] Starting dynamic subtest: coherency [262.745406] Dynamic subtest coherency: SUCCESS (1.040s) [262.754763] Starting dynamic subtest: gtt [270.360699] Dynamic subtest gtt: SUCCESS (7.614s) [270.368269] Starting dynamic subtest: gem [271.007484] Dynamic subtest gem: SUCCESS (0.646s) [271.014777] Starting dynamic subtest: evict [272.305555] Dynamic subtest evict: SUCCESS (1.297s) [272.313420] Starting dynamic subtest: hugepages [278.760794] Dynamic subtest hugepages: SUCCESS (6.454s) [278.768699] Starting dynamic subtest: gem_contexts [290.844698] Dynamic subtest gem_contexts: SUCCESS (12.083s) [290.851877] Starting dynamic subtest: client [291.382520] Dynamic subtest client: SUCCESS (0.537s) [291.389643] Starting dynamic subtest: gem_migrate [291.903533] Dynamic subtest gem_migrate: SUCCESS (0.520s) [291.910616] Starting dynamic subtest: reset [292.819486] Dynamic subtest reset: SUCCESS (0.915s) [292.827120] Starting dynamic subtest: memory_region [293.329510] Dynamic subtest memory_region: SUCCESS (0.509s) [293.336712] Starting dynamic subtest: hangcheck [316.837415] Dynamic subtest hangcheck: SUCCESS (23.507s) [316.844155] Starting dynamic subtest: execlists [325.192855] Dynamic subtest execlists: SUCCESS (8.354s) [325.221578] Starting dynamic subtest: ring_submission [325.746760] Dynamic subtest ring_submission: SUCCESS (0.553s) [325.754246] Starting dynamic subtest: perf [326.363777] Dynamic subtest perf: SUCCESS (0.616s) [326.371544] Starting dynamic subtest: slpc [326.888624] Dynamic subtest slpc: SUCCESS (0.524s) [326.896193] Starting dynamic subtest: guc [327.436401] Dynamic subtest guc: SUCCESS (0.547s) [327.443747] Starting dynamic subtest: guc_multi_lrc [327.980665] Dynamic subtest guc_multi_lrc: SUCCESS (0.543s) [327.988276] Starting dynamic subtest: guc_hang [328.504418] Dynamic subtest guc_hang: SUCCESS (0.523s) [328.512069] Starting dynamic subtest: late_gt_pm [329.075576] Dynamic subtest late_gt_pm: SUCCESS (0.570s) [329.078999] Subtest live: SUCCESS (101.604s) [329.308904] [165/171] (678s left) dmabuf (all-tests) [329.379609] Starting subtest: all-tests [329.387748] Starting dynamic subtest: sanitycheck [329.462623] Dynamic subtest sanitycheck: SUCCESS (0.082s) [329.486054] Starting dynamic subtest: dma_fence [329.664657] Dynamic subtest dma_fence: SUCCESS (0.200s) [329.683814] Starting dynamic subtest: dma_fence_chain [340.104279] Dynamic subtest dma_fence_chain: SUCCESS (10.438s) [340.113469] Starting dynamic subtest: dma_fence_unwrap [340.172488] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [340.180849] Starting dynamic subtest: dma_resv [340.242285] Dynamic subtest dma_resv: SUCCESS (0.067s) [340.246375] Subtest all-tests: SUCCESS (10.864s) [340.295796] [166/171] (667s left) i915_suspend (basic-s2idle-without-i915) [340.389639] Starting subtest: basic-s2idle-without-i915 [357.673679] Subtest basic-s2idle-without-i915: SUCCESS (2.535s) [362.835974] [167/171] (664s left) i915_suspend (basic-s3-without-i915) [362.899533] Starting subtest: basic-s3-without-i915 [381.829462] Subtest basic-s3-without-i915: SUCCESS (2.265s) [388.601733] [168/171] (662s left) gem_exec_suspend (basic-s0) [388.674848] Starting subtest: basic-S0 [388.678110] Starting dynamic subtest: smem [405.705606] Dynamic subtest smem: SUCCESS (1.774s) [405.708872] Subtest basic-S0: SUCCESS (1.775s) [413.884667] [169/171] (660s left) gem_exec_suspend (basic-s3) [413.953423] Starting subtest: basic-S3 [413.956901] Starting dynamic subtest: smem [431.827159] Dynamic subtest smem: SUCCESS (1.966s) [431.830111] Subtest basic-S3: SUCCESS (1.967s) [439.028404] [170/171] (658s left) kms_chamelium_hpd (common-hpd-after-suspend) [439.213823] Subtest common-hpd-after-suspend: SKIP (0.000s) [439.287178] [171/171] (658s left) kms_pipe_crc_basic (suspend-read-crc) [439.397806] Starting subtest: suspend-read-crc [439.400746] Starting dynamic subtest: pipe-A-HDMI-A-1 [457.948388] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.833s) [457.962524] Starting dynamic subtest: pipe-B-HDMI-A-1 [476.983294] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.975s) [476.993287] Starting dynamic subtest: pipe-C-HDMI-A-1 [496.014908] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.943s) [496.017897] Subtest suspend-read-crc: SUCCESS (5.754s) [501.088190] Closing watchdogs Done.