[42.953381] Initializing watchdogs [42.953454] /dev/watchdog0 [42.958514] [001/171] (960s left) i915_module_load (load) [43.026880] Starting subtest: load [44.681176] Subtest load: SUCCESS (1.652s) [44.699108] [002/171] (958s left) core_auth (basic-auth) [44.794218] Starting subtest: basic-auth [44.798132] Subtest basic-auth: SUCCESS (0.002s) [44.858950] [003/171] (958s left) debugfs_test (read_all_entries) [44.923933] Starting subtest: read_all_entries [44.979502] Subtest read_all_entries: SUCCESS (0.055s) [45.224683] [004/171] (958s left) debugfs_test (basic-hwmon) [45.285476] Starting subtest: basic-hwmon [45.286626] Subtest basic-hwmon: SKIP (0.000s) [45.542622] [005/171] (957s left) fbdev (eof) [45.613045] Starting subtest: eof [45.613713] Subtest eof: SUCCESS (0.000s) [45.660389] [006/171] (957s left) fbdev (info) [45.726230] Starting subtest: info [45.726685] Subtest info: SUCCESS (0.000s) [45.774990] [007/171] (957s left) fbdev (nullptr) [45.846763] Starting subtest: nullptr [45.847747] Subtest nullptr: SUCCESS (0.000s) [45.897399] [008/171] (957s left) fbdev (read) [45.979696] Starting subtest: read [46.212570] Subtest read: SUCCESS (0.233s) [46.257676] [009/171] (957s left) fbdev (write) [46.330047] Starting subtest: write [46.450879] Subtest write: SUCCESS (0.121s) [46.490761] [010/171] (957s left) gem_basic (bad-close) [46.548974] Starting subtest: bad-close [46.550115] Subtest bad-close: SUCCESS (0.000s) [46.608580] [011/171] (956s left) gem_basic (create-close) [46.669940] Starting subtest: create-close [46.670887] Subtest create-close: SUCCESS (0.000s) [46.748523] [012/171] (956s left) gem_basic (create-fd-close) [46.850810] Starting subtest: create-fd-close [46.851916] Subtest create-fd-close: SUCCESS (0.000s) [46.910765] [013/171] (956s left) gem_busy (busy@all-engines) [46.984922] Starting subtest: busy [46.985542] Starting dynamic subtest: all-engines [47.032589] Dynamic subtest all-engines: SUCCESS (0.048s) [47.033257] Subtest busy: SUCCESS (0.048s) [47.365320] [014/171] (956s left) gem_close_race (basic-process) [47.451437] Starting subtest: basic-process [47.499208] Subtest basic-process: SUCCESS (0.048s) [47.695107] [015/171] (955s left) gem_close_race (basic-threads) [47.771813] Starting subtest: basic-threads [48.959467] Subtest basic-threads: SUCCESS (1.188s) [49.148143] [016/171] (954s left) gem_ctx_create (basic) [49.227892] Starting subtest: basic [49.228354] Subtest basic: SUCCESS (0.000s) [49.416625] [017/171] (954s left) gem_ctx_create (basic-files) [49.487866] Starting subtest: basic-files [51.500344] Subtest basic-files: SUCCESS (2.012s) [51.722202] [018/171] (952s left) gem_ctx_exec (basic) [51.813914] Starting subtest: basic [51.816163] Subtest basic: SUCCESS (0.002s) [51.932993] [019/171] (951s left) gem_exec_basic (basic) [52.024483] Starting subtest: basic [52.025153] Starting dynamic subtest: rcs0-smem [52.025856] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.032092] Starting dynamic subtest: bcs0-smem [52.032672] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [52.037942] Starting dynamic subtest: vcs0-smem [52.038659] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.043465] Starting dynamic subtest: vcs1-smem [52.043940] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [52.048558] Starting dynamic subtest: vecs0-smem [52.049025] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.049475] Subtest basic: SUCCESS (0.003s) [52.252760] [020/171] (951s left) gem_exec_create (basic) [52.349577] Starting subtest: basic [52.350040] Starting dynamic subtest: smem [54.391963] Dynamic subtest smem: SUCCESS (2.042s) [54.392788] Subtest basic: SUCCESS (2.043s) [54.600106] [021/171] (949s left) gem_exec_fence (basic-busy) [54.794809] Starting subtest: basic-busy [54.795861] Starting dynamic subtest: rcs0 [54.828549] Dynamic subtest rcs0: SUCCESS (0.033s) [54.844967] Starting dynamic subtest: bcs0 [54.858405] Dynamic subtest bcs0: SUCCESS (0.030s) [54.871285] Starting dynamic subtest: vcs0 [54.881460] Dynamic subtest vcs0: SUCCESS (0.023s) [54.892555] Starting dynamic subtest: vcs1 [54.906115] Dynamic subtest vcs1: SUCCESS (0.025s) [54.914858] Starting dynamic subtest: vecs0 [54.921972] Dynamic subtest vecs0: SUCCESS (0.016s) [54.922644] Subtest basic-busy: SUCCESS (0.127s) [55.500627] [022/171] (948s left) gem_exec_fence (basic-wait) [55.702824] Starting subtest: basic-wait [55.704202] Starting dynamic subtest: rcs0 [55.744259] Dynamic subtest rcs0: SUCCESS (0.041s) [55.762970] Starting dynamic subtest: bcs0 [55.767631] Dynamic subtest bcs0: SUCCESS (0.023s) [55.779930] Starting dynamic subtest: vcs0 [55.802167] Dynamic subtest vcs0: SUCCESS (0.035s) [55.812861] Starting dynamic subtest: vcs1 [55.836318] Dynamic subtest vcs1: SUCCESS (0.034s) [55.847073] Starting dynamic subtest: vecs0 [55.856148] Dynamic subtest vecs0: SUCCESS (0.020s) [55.857057] Subtest basic-wait: SUCCESS (0.154s) [56.416384] [023/171] (947s left) gem_exec_fence (basic-await) [56.609313] Starting subtest: basic-await [56.610312] Starting dynamic subtest: rcs0 [56.706641] Dynamic subtest rcs0: SUCCESS (0.097s) [56.715561] Starting dynamic subtest: bcs0 [56.796918] Dynamic subtest bcs0: SUCCESS (0.090s) [56.806104] Starting dynamic subtest: vcs0 [56.892651] Dynamic subtest vcs0: SUCCESS (0.095s) [56.901801] Starting dynamic subtest: vcs1 [56.989336] Dynamic subtest vcs1: SUCCESS (0.096s) [56.998694] Starting dynamic subtest: vecs0 [57.093672] Dynamic subtest vecs0: SUCCESS (0.104s) [57.094725] Subtest basic-await: SUCCESS (0.484s) [57.703988] [024/171] (946s left) gem_exec_fence (nb-await) [57.909256] Starting subtest: nb-await [57.910405] Starting dynamic subtest: rcs0 [57.979174] Dynamic subtest rcs0: SUCCESS (0.069s) [57.997047] Starting dynamic subtest: bcs0 [58.052263] Dynamic subtest bcs0: SUCCESS (0.073s) [58.069208] Starting dynamic subtest: vcs0 [58.124426] Dynamic subtest vcs0: SUCCESS (0.072s) [58.141786] Starting dynamic subtest: vcs1 [58.193814] Dynamic subtest vcs1: SUCCESS (0.069s) [58.216289] Starting dynamic subtest: vecs0 [58.274569] Dynamic subtest vecs0: SUCCESS (0.077s) [58.276347] Subtest nb-await: SUCCESS (0.362s) [58.855653] [025/171] (945s left) gem_exec_gttfill (basic) [58.947394] Starting subtest: basic [62.413368] Subtest basic: SUCCESS (3.466s) [62.578783] [026/171] (941s left) gem_exec_parallel (engines) [62.743528] Starting subtest: engines [62.744019] Starting dynamic subtest: basic [64.400157] Dynamic subtest basic: SUCCESS (1.657s) [64.406476] Starting dynamic subtest: contexts [66.695847] Dynamic subtest contexts: SUCCESS (2.295s) [66.702318] Starting dynamic subtest: fds [69.249379] Dynamic subtest fds: SUCCESS (2.553s) [69.255931] Starting dynamic subtest: userptr [71.013906] Dynamic subtest userptr: SUCCESS (1.764s) [71.014413] Subtest engines: SUCCESS (8.270s) [71.199819] [027/171] (932s left) gem_exec_store (basic) [71.278308] Starting subtest: basic [71.325842] Subtest basic: SUCCESS (0.048s) [71.521267] [028/171] (932s left) gem_flink_basic (bad-flink) [71.602878] Starting subtest: bad-flink [71.603377] Subtest bad-flink: SUCCESS (0.000s) [71.659451] [029/171] (932s left) gem_flink_basic (bad-open) [71.718268] Starting subtest: bad-open [71.718867] Subtest bad-open: SUCCESS (0.000s) [71.779678] [030/171] (932s left) gem_flink_basic (basic) [71.848034] Starting subtest: basic [71.848588] Subtest basic: SUCCESS (0.000s) [71.913751] [031/171] (932s left) gem_flink_basic (double-flink) [71.984119] Starting subtest: double-flink [71.984620] Subtest double-flink: SUCCESS (0.000s) [72.073164] [032/171] (932s left) gem_flink_basic (flink-lifetime) [72.157730] Starting subtest: flink-lifetime [72.158970] Subtest flink-lifetime: SUCCESS (0.001s) [72.232526] [033/171] (931s left) gem_huc_copy (huc-copy) [72.308846] Starting subtest: huc-copy [72.309834] Subtest huc-copy: SKIP (0.000s) [72.421974] [034/171] (931s left) gem_linear_blits (basic) [72.566888] Starting subtest: basic [72.572490] Subtest basic: SUCCESS (0.006s) [72.725514] [035/171] (931s left) gem_mmap (basic) [72.908226] Starting subtest: basic [72.911866] Subtest basic: SUCCESS (0.001s) [72.999610] [036/171] (931s left) gem_mmap_gtt (basic) [73.082993] Starting subtest: basic [73.083664] Subtest basic: SUCCESS (0.000s) [73.136977] [037/171] (931s left) gem_render_linear_blits (basic) [73.198709] Starting subtest: basic [73.222640] Subtest basic: SUCCESS (0.024s) [73.271068] [038/171] (930s left) gem_render_tiled_blits (basic) [73.332019] Starting subtest: basic [73.359103] Subtest basic: SUCCESS (0.027s) [73.386959] [039/171] (930s left) gem_ringfill (basic-all) [73.653721] Starting subtest: basic-all [74.813253] Subtest basic-all: SUCCESS (1.160s) [74.916644] [040/171] (929s left) gem_softpin (allocator-basic) [74.983228] Starting subtest: allocator-basic [75.058057] Subtest allocator-basic: SUCCESS (0.075s) [75.171055] [041/171] (929s left) gem_softpin (allocator-basic-reserve) [75.255015] Starting subtest: allocator-basic-reserve [75.332728] Subtest allocator-basic-reserve: SUCCESS (0.078s) [75.448225] [042/171] (928s left) gem_softpin (safe-alignment) [75.537787] Starting subtest: safe-alignment [75.547793] Subtest safe-alignment: SUCCESS (0.010s) [75.641976] [043/171] (928s left) gem_sync (basic-all) [75.735034] Starting subtest: basic-all [78.018949] Subtest basic-all: SUCCESS (2.284s) [78.203030] [044/171] (926s left) gem_sync (basic-each) [78.295902] Starting subtest: basic-each [80.469940] Subtest basic-each: SUCCESS (2.174s) [80.674914] [045/171] (923s left) gem_tiled_blits (basic) [80.864697] Starting subtest: basic [80.879666] Subtest basic: SUCCESS (0.016s) [81.038901] [046/171] (923s left) gem_tiled_fence_blits (basic) [81.275445] Starting subtest: basic [81.283605] Subtest basic: SUCCESS (0.008s) [81.423286] [047/171] (923s left) gem_tiled_pread_basic [81.744907] [048/171] (922s left) gem_wait (busy@all-engines) [81.821765] Starting subtest: busy [81.822268] Starting dynamic subtest: all-engines [82.335633] Dynamic subtest all-engines: SUCCESS (0.514s) [82.336135] Subtest busy: SUCCESS (0.514s) [82.540229] [049/171] (922s left) gem_wait (wait@all-engines) [82.633234] Starting subtest: wait [82.633831] Starting dynamic subtest: all-engines [83.658985] Dynamic subtest all-engines: SUCCESS (1.025s) [83.660375] Subtest wait: SUCCESS (1.025s) [83.871934] [050/171] (920s left) i915_getparams_basic (basic-eu-total) [83.949943] Starting subtest: basic-eu-total [83.950939] Subtest basic-eu-total: SUCCESS (0.000s) [84.010028] [051/171] (920s left) i915_getparams_basic (basic-subslice-total) [84.067980] Starting subtest: basic-subslice-total [84.069659] Subtest basic-subslice-total: SUCCESS (0.000s) [84.128098] [052/171] (920s left) i915_hangman (error-state-basic) [84.200375] Starting subtest: error-state-basic [84.206219] Subtest error-state-basic: SUCCESS (0.006s) [84.260117] [053/171] (920s left) i915_pciid [84.381048] [054/171] (920s left) kms_addfb_basic (addfb25-bad-modifier) [84.453549] Starting subtest: addfb25-bad-modifier [84.454944] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [84.727144] [055/171] (919s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [84.789231] Starting subtest: addfb25-framebuffer-vs-set-tiling [84.789747] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [85.060993] [056/171] (919s left) kms_addfb_basic (addfb25-modifier-no-flag) [85.123121] Starting subtest: addfb25-modifier-no-flag [85.123619] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [85.407878] [057/171] (919s left) kms_addfb_basic (addfb25-x-tiled-legacy) [85.492129] Starting subtest: addfb25-x-tiled-legacy [85.492740] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [85.742938] [058/171] (918s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [85.801696] Starting subtest: addfb25-x-tiled-mismatch-legacy [85.802827] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [86.104223] [059/171] (918s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [86.380128] Starting subtest: addfb25-yf-tiled-legacy [86.380897] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [86.463591] [060/171] (918s left) kms_addfb_basic (addfb25-y-tiled-legacy) [86.726060] Starting subtest: addfb25-y-tiled-legacy [86.726698] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [86.794338] [061/171] (918s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [87.052442] Starting subtest: addfb25-y-tiled-small-legacy [87.053094] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [87.134878] [062/171] (917s left) kms_addfb_basic (bad-pitch-0) [87.205129] Starting subtest: bad-pitch-0 [87.205761] Subtest bad-pitch-0: SUCCESS (0.000s) [87.476827] [063/171] (917s left) kms_addfb_basic (bad-pitch-1024) [87.536274] Starting subtest: bad-pitch-1024 [87.536798] Subtest bad-pitch-1024: SUCCESS (0.000s) [87.809381] [064/171] (917s left) kms_addfb_basic (bad-pitch-128) [87.867894] Starting subtest: bad-pitch-128 [87.868454] Subtest bad-pitch-128: SUCCESS (0.000s) [88.148431] [065/171] (916s left) kms_addfb_basic (bad-pitch-256) [88.222849] Starting subtest: bad-pitch-256 [88.223282] Subtest bad-pitch-256: SUCCESS (0.000s) [88.511104] [066/171] (916s left) kms_addfb_basic (bad-pitch-32) [88.572396] Starting subtest: bad-pitch-32 [88.573016] Subtest bad-pitch-32: SUCCESS (0.000s) [88.845495] [067/171] (916s left) kms_addfb_basic (bad-pitch-63) [88.910518] Starting subtest: bad-pitch-63 [88.911203] Subtest bad-pitch-63: SUCCESS (0.000s) [89.176490] [068/171] (915s left) kms_addfb_basic (bad-pitch-65536) [89.236526] Starting subtest: bad-pitch-65536 [89.236981] Subtest bad-pitch-65536: SUCCESS (0.000s) [89.514399] [069/171] (915s left) kms_addfb_basic (bad-pitch-999) [89.585468] Starting subtest: bad-pitch-999 [89.586057] Subtest bad-pitch-999: SUCCESS (0.000s) [89.843864] [070/171] (915s left) kms_addfb_basic (basic) [89.904570] Starting subtest: basic [89.905307] Subtest basic: SUCCESS (0.000s) [90.179223] [071/171] (914s left) kms_addfb_basic (basic-x-tiled-legacy) [90.246702] Starting subtest: basic-x-tiled-legacy [90.247193] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [90.513595] [072/171] (914s left) kms_addfb_basic (basic-y-tiled-legacy) [90.581589] Starting subtest: basic-y-tiled-legacy [90.582321] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [90.844090] [073/171] (914s left) kms_addfb_basic (bo-too-small) [91.101985] Starting subtest: bo-too-small [91.102585] Subtest bo-too-small: SUCCESS (0.000s) [91.204911] [074/171] (913s left) kms_addfb_basic (bo-too-small-due-to-tiling) [91.482584] Starting subtest: bo-too-small-due-to-tiling [91.483045] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [91.559308] [075/171] (913s left) kms_addfb_basic (clobberred-modifier) [91.617163] Starting subtest: clobberred-modifier [91.617817] Subtest clobberred-modifier: SUCCESS (0.000s) [91.900155] [076/171] (913s left) kms_addfb_basic (framebuffer-vs-set-tiling) [91.976896] Starting subtest: framebuffer-vs-set-tiling [91.977425] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [92.243300] [077/171] (912s left) kms_addfb_basic (invalid-get-prop) [92.300838] Starting subtest: invalid-get-prop [92.301353] Subtest invalid-get-prop: SUCCESS (0.000s) [92.582688] [078/171] (912s left) kms_addfb_basic (invalid-get-prop-any) [92.656489] Starting subtest: invalid-get-prop-any [92.657036] Subtest invalid-get-prop-any: SUCCESS (0.000s) [92.926132] [079/171] (912s left) kms_addfb_basic (invalid-set-prop) [92.988719] Starting subtest: invalid-set-prop [92.989154] Subtest invalid-set-prop: SUCCESS (0.000s) [93.260285] [080/171] (911s left) kms_addfb_basic (invalid-set-prop-any) [93.319480] Starting subtest: invalid-set-prop-any [93.320028] Subtest invalid-set-prop-any: SUCCESS (0.000s) [93.599389] [081/171] (911s left) kms_addfb_basic (no-handle) [93.676967] Starting subtest: no-handle [93.677921] Subtest no-handle: SUCCESS (0.000s) [93.946269] [082/171] (911s left) kms_addfb_basic (size-max) [94.206898] Starting subtest: size-max [94.207667] Subtest size-max: SUCCESS (0.000s) [94.299667] [083/171] (910s left) kms_addfb_basic (small-bo) [94.572868] Starting subtest: small-bo [94.573500] Subtest small-bo: SUCCESS (0.000s) [94.643727] [084/171] (910s left) kms_addfb_basic (tile-pitch-mismatch) [94.703572] Starting subtest: tile-pitch-mismatch [94.704225] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [94.981121] [085/171] (910s left) kms_addfb_basic (too-high) [95.244939] Starting subtest: too-high [95.245668] Subtest too-high: SUCCESS (0.001s) [95.330179] [086/171] (909s left) kms_addfb_basic (too-wide) [95.597215] Starting subtest: too-wide [95.597821] Subtest too-wide: SUCCESS (0.000s) [95.680953] [087/171] (909s left) kms_addfb_basic (unused-handle) [95.752818] Starting subtest: unused-handle [95.753233] Subtest unused-handle: SUCCESS (0.000s) [96.026074] [088/171] (909s left) kms_addfb_basic (unused-modifier) [96.083630] Starting subtest: unused-modifier [96.084196] Subtest unused-modifier: SUCCESS (0.000s) [96.344365] [089/171] (908s left) kms_addfb_basic (unused-offsets) [96.405833] Starting subtest: unused-offsets [96.406318] Subtest unused-offsets: SUCCESS (0.000s) [96.679062] [090/171] (908s left) kms_addfb_basic (unused-pitches) [96.744444] Starting subtest: unused-pitches [96.745109] Subtest unused-pitches: SUCCESS (0.000s) [97.012263] [091/171] (908s left) kms_busy (basic) [97.275816] Starting subtest: basic [97.277009] Starting dynamic subtest: flip [97.968234] Dynamic subtest flip: SUCCESS (0.691s) [97.977394] Starting dynamic subtest: modeset [98.970402] Dynamic subtest modeset: SUCCESS (1.002s) [98.972047] Subtest basic: SUCCESS (1.694s) [99.227120] [092/171] (906s left) kms_chamelium_hpd (dp-hpd-fast) [99.535497] Subtest dp-hpd-fast: SKIP (0.000s) [99.745801] [093/171] (905s left) kms_chamelium_edid (dp-edid-read) [100.058374] Subtest dp-edid-read: SKIP (0.000s) [100.267597] [094/171] (905s left) kms_chamelium_frames (dp-crc-fast) [100.578996] Subtest dp-crc-fast: SKIP (0.000s) [100.790302] [095/171] (904s left) kms_chamelium_hpd (hdmi-hpd-fast) [101.099637] Subtest hdmi-hpd-fast: SKIP (0.000s) [101.301784] [096/171] (904s left) kms_chamelium_edid (hdmi-edid-read) [101.614936] Subtest hdmi-edid-read: SKIP (0.000s) [101.833361] [097/171] (903s left) kms_chamelium_frames (hdmi-crc-fast) [102.144915] Subtest hdmi-crc-fast: SKIP (0.000s) [102.347613] [098/171] (903s left) kms_chamelium_hpd (vga-hpd-fast) [102.658405] Subtest vga-hpd-fast: SKIP (0.000s) [102.867093] [099/171] (902s left) kms_chamelium_edid (vga-edid-read) [103.178176] Subtest vga-edid-read: SKIP (0.000s) [103.384332] [100/171] (902s left) kms_prop_blob (basic) [103.444124] Starting subtest: basic [103.444773] Subtest basic: SUCCESS (0.000s) [103.505440] [101/171] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [103.766772] Starting subtest: basic-busy-flip-before-cursor-atomic [103.767753] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [103.820520] [102/171] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [104.071187] Starting subtest: basic-busy-flip-before-cursor-legacy [104.072262] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [104.137324] [103/171] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [104.393264] Starting subtest: basic-flip-after-cursor-atomic [105.344967] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.951s) [105.599391] [104/171] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [105.851227] Starting subtest: basic-flip-after-cursor-legacy [106.789736] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.938s) [107.044923] [105/171] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [107.297235] Starting subtest: basic-flip-after-cursor-varying-size [108.269253] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.971s) [108.531600] [106/171] (896s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [108.785381] Starting subtest: basic-flip-before-cursor-atomic [109.750527] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.965s) [110.003244] [107/171] (895s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [110.255388] Starting subtest: basic-flip-before-cursor-legacy [111.205770] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.950s) [111.461232] [108/171] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [111.715371] Starting subtest: basic-flip-before-cursor-varying-size [112.669485] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.953s) [112.917654] [109/171] (892s left) kms_flip (basic-flip-vs-dpms) [113.107501] Starting subtest: basic-flip-vs-dpms [113.109656] Starting dynamic subtest: A-DP1 [114.275879] Dynamic subtest A-DP1: SUCCESS (1.165s) [114.287998] Starting dynamic subtest: B-DP1 [115.397164] Dynamic subtest B-DP1: SUCCESS (1.121s) [115.405599] Starting dynamic subtest: C-DP1 [116.519532] Dynamic subtest C-DP1: SUCCESS (1.121s) [116.524108] Subtest basic-flip-vs-dpms: SUCCESS (3.413s) [116.783310] [110/171] (888s left) kms_flip (basic-flip-vs-modeset) [116.983185] Starting subtest: basic-flip-vs-modeset [116.984318] Starting dynamic subtest: A-DP1 [118.165417] Dynamic subtest A-DP1: SUCCESS (1.181s) [118.176851] Starting dynamic subtest: B-DP1 [119.268930] Dynamic subtest B-DP1: SUCCESS (1.102s) [119.276891] Starting dynamic subtest: C-DP1 [120.393749] Dynamic subtest C-DP1: SUCCESS (1.123s) [120.394329] Subtest basic-flip-vs-modeset: SUCCESS (3.412s) [120.644919] [111/171] (884s left) kms_flip (basic-flip-vs-wf_vblank) [120.836378] Starting subtest: basic-flip-vs-wf_vblank [120.838666] Starting dynamic subtest: A-DP1 [122.151299] Dynamic subtest A-DP1: SUCCESS (1.312s) [122.159317] Starting dynamic subtest: B-DP1 [123.416323] Dynamic subtest B-DP1: SUCCESS (1.264s) [123.424518] Starting dynamic subtest: C-DP1 [124.680985] Dynamic subtest C-DP1: SUCCESS (1.263s) [124.683404] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.846s) [124.985856] [112/171] (880s left) kms_flip (basic-plain-flip) [125.173486] Starting subtest: basic-plain-flip [125.174640] Starting dynamic subtest: A-DP1 [126.185717] Dynamic subtest A-DP1: SUCCESS (1.011s) [126.193613] Starting dynamic subtest: B-DP1 [127.164231] Dynamic subtest B-DP1: SUCCESS (0.977s) [127.173638] Starting dynamic subtest: C-DP1 [128.126932] Dynamic subtest C-DP1: SUCCESS (0.962s) [128.128606] Subtest basic-plain-flip: SUCCESS (2.956s) [128.432791] [113/171] (877s left) kms_force_connector_basic (force-connector-state) [128.701303] Starting subtest: force-connector-state [129.466446] Subtest force-connector-state: SUCCESS (0.767s) [130.281113] [114/171] (875s left) kms_force_connector_basic (force-edid) [130.522993] Starting subtest: force-edid [130.880742] Subtest force-edid: SUCCESS (0.358s) [131.397979] [115/171] (874s left) kms_force_connector_basic (force-load-detect) [131.641791] Starting subtest: force-load-detect [131.645575] Subtest force-load-detect: SKIP (0.000s) [132.035158] [116/171] (873s left) kms_force_connector_basic (prune-stale-modes) [132.300426] Starting subtest: prune-stale-modes [132.707439] Subtest prune-stale-modes: SUCCESS (0.410s) [133.231182] [117/171] (872s left) kms_frontbuffer_tracking (basic) [133.491626] Starting subtest: basic [135.951741] Subtest basic: SUCCESS (2.459s) [136.047359] [118/171] (869s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [136.303234] Starting subtest: compare-crc-sanitycheck-xr24 [136.305077] Starting dynamic subtest: pipe-A-DP-1 [136.706443] Dynamic subtest pipe-A-DP-1: SUCCESS (0.402s) [136.718458] Starting dynamic subtest: pipe-B-DP-1 [137.267782] Dynamic subtest pipe-B-DP-1: SUCCESS (0.558s) [137.275957] Starting dynamic subtest: pipe-C-DP-1 [137.848637] Dynamic subtest pipe-C-DP-1: SUCCESS (0.578s) [137.849117] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.545s) [138.104322] [119/171] (867s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [138.357433] Starting subtest: compare-crc-sanitycheck-nv12 [138.360331] Starting dynamic subtest: pipe-A-DP-1 [138.794374] Dynamic subtest pipe-A-DP-1: SUCCESS (0.435s) [138.805414] Starting dynamic subtest: pipe-B-DP-1 [139.385744] Dynamic subtest pipe-B-DP-1: SUCCESS (0.589s) [139.394275] Starting dynamic subtest: pipe-C-DP-1 [139.395480] Dynamic subtest pipe-C-DP-1: SKIP (0.000s) [139.395962] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.031s) [139.637076] [120/171] (866s left) kms_pipe_crc_basic (hang-read-crc) [139.890425] Starting subtest: hang-read-crc [139.891812] Starting dynamic subtest: pipe-A-DP-1 [141.028108] Dynamic subtest pipe-A-DP-1: SUCCESS (1.136s) [141.042481] Starting dynamic subtest: pipe-B-DP-1 [142.350346] Dynamic subtest pipe-B-DP-1: SUCCESS (1.319s) [142.364713] Starting dynamic subtest: pipe-C-DP-1 [143.719262] Dynamic subtest pipe-C-DP-1: SUCCESS (1.368s) [143.719823] Subtest hang-read-crc: SUCCESS (3.829s) [143.957846] [121/171] (861s left) kms_pipe_crc_basic (nonblocking-crc) [144.221485] Starting subtest: nonblocking-crc [144.223097] Starting dynamic subtest: pipe-A-DP-1 [144.815306] Dynamic subtest pipe-A-DP-1: SUCCESS (0.591s) [144.830688] Starting dynamic subtest: pipe-B-DP-1 [145.523521] Dynamic subtest pipe-B-DP-1: SUCCESS (0.706s) [145.537354] Starting dynamic subtest: pipe-C-DP-1 [146.282845] Dynamic subtest pipe-C-DP-1: SUCCESS (0.758s) [146.284221] Subtest nonblocking-crc: SUCCESS (2.062s) [146.526855] [122/171] (859s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [146.783499] Starting subtest: nonblocking-crc-frame-sequence [146.784925] Starting dynamic subtest: pipe-A-DP-1 [147.349932] Dynamic subtest pipe-A-DP-1: SUCCESS (0.565s) [147.359965] Starting dynamic subtest: pipe-B-DP-1 [148.072887] Dynamic subtest pipe-B-DP-1: SUCCESS (0.721s) [148.086026] Starting dynamic subtest: pipe-C-DP-1 [148.826949] Dynamic subtest pipe-C-DP-1: SUCCESS (0.752s) [148.827551] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.044s) [149.066899] [123/171] (856s left) kms_pipe_crc_basic (read-crc) [149.324392] Starting subtest: read-crc [149.326069] Starting dynamic subtest: pipe-A-DP-1 [149.824543] Dynamic subtest pipe-A-DP-1: SUCCESS (0.499s) [149.834593] Starting dynamic subtest: pipe-B-DP-1 [150.472434] Dynamic subtest pipe-B-DP-1: SUCCESS (0.644s) [150.486055] Starting dynamic subtest: pipe-C-DP-1 [151.156886] Dynamic subtest pipe-C-DP-1: SUCCESS (0.683s) [151.158160] Subtest read-crc: SUCCESS (1.833s) [151.403669] [124/171] (854s left) kms_pipe_crc_basic (read-crc-frame-sequence) [151.654206] Starting subtest: read-crc-frame-sequence [151.655922] Starting dynamic subtest: pipe-A-DP-1 [152.159295] Dynamic subtest pipe-A-DP-1: SUCCESS (0.502s) [152.172928] Starting dynamic subtest: pipe-B-DP-1 [152.798805] Dynamic subtest pipe-B-DP-1: SUCCESS (0.639s) [152.806936] Starting dynamic subtest: pipe-C-DP-1 [153.486231] Dynamic subtest pipe-C-DP-1: SUCCESS (0.685s) [153.486811] Subtest read-crc-frame-sequence: SUCCESS (1.832s) [153.727153] [125/171] (852s left) kms_psr (primary_page_flip) [153.787896] Subtest primary_page_flip: SKIP (0.000s) [153.821281] [126/171] (851s left) kms_psr (cursor_plane_move) [153.880016] Subtest cursor_plane_move: SKIP (0.000s) [153.904555] [127/171] (851s left) kms_psr (sprite_plane_onoff) [153.961834] Subtest sprite_plane_onoff: SKIP (0.000s) [153.987398] [128/171] (851s left) kms_psr (primary_mmap_gtt) [154.044780] Subtest primary_mmap_gtt: SKIP (0.000s) [154.071347] [129/171] (851s left) kms_setmode (basic-clone-single-crtc) [154.130702] Starting subtest: basic-clone-single-crtc [154.131899] Subtest basic-clone-single-crtc: SKIP (0.000s) [154.195456] [130/171] (851s left) i915_pm_backlight (basic-brightness) [154.452119] Subtest basic-brightness: SKIP (0.000s) [154.471042] [131/171] (851s left) i915_pm_rpm (basic-pci-d3-state) [156.256343] Starting subtest: basic-pci-d3-state [167.033061] Subtest basic-pci-d3-state: FAIL (10.761s) [167.413359] [132/171] (838s left) i915_pm_rpm (basic-rte) [167.495312] Starting subtest: basic-rte [179.867472] Subtest basic-rte: FAIL (12.339s) [191.013550] [133/171] (814s left) i915_pm_rps (basic-api) [191.099165] Starting subtest: basic-api [191.104156] Subtest basic-api: SUCCESS (0.005s) [191.171979] [134/171] (814s left) prime_self_import (basic-llseek-bad) [191.243539] Starting subtest: basic-llseek-bad [191.245559] Subtest basic-llseek-bad: SUCCESS (0.002s) [191.325706] [135/171] (814s left) prime_self_import (basic-llseek-size) [191.400574] Starting subtest: basic-llseek-size [191.403850] Subtest basic-llseek-size: SUCCESS (0.003s) [191.491905] [136/171] (814s left) prime_self_import (basic-with_fd_dup) [191.558277] Starting subtest: basic-with_fd_dup [191.560542] Subtest basic-with_fd_dup: SUCCESS (0.002s) [191.639937] [137/171] (814s left) prime_self_import (basic-with_one_bo) [191.711799] Starting subtest: basic-with_one_bo [191.713840] Subtest basic-with_one_bo: SUCCESS (0.003s) [191.761074] [138/171] (814s left) prime_self_import (basic-with_one_bo_two_files) [191.819219] Starting subtest: basic-with_one_bo_two_files [191.821703] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [191.906396] [139/171] (814s left) prime_self_import (basic-with_two_bos) [191.985359] Starting subtest: basic-with_two_bos [191.987672] Subtest basic-with_two_bos: SUCCESS (0.002s) [192.083931] [140/171] (813s left) prime_vgem (basic-fence-flip) [192.198288] Starting subtest: basic-fence-flip [192.802544] Subtest basic-fence-flip: SUCCESS (0.603s) [192.903548] [141/171] (813s left) prime_vgem (basic-fence-mmap) [193.001727] Starting subtest: basic-fence-mmap [193.034298] Subtest basic-fence-mmap: SUCCESS (0.034s) [193.129656] [142/171] (812s left) prime_vgem (basic-fence-read) [193.230739] Starting subtest: basic-fence-read [193.260379] Subtest basic-fence-read: SUCCESS (0.029s) [193.318072] [143/171] (812s left) prime_vgem (basic-gtt) [193.389959] Starting subtest: basic-gtt [193.398553] Subtest basic-gtt: SUCCESS (0.008s) [193.468985] [144/171] (812s left) prime_vgem (basic-read) [193.569762] Starting subtest: basic-read [193.583229] Subtest basic-read: SUCCESS (0.013s) [193.692724] [145/171] (812s left) prime_vgem (basic-write) [193.796612] Starting subtest: basic-write [193.810859] Subtest basic-write: SUCCESS (0.014s) [193.924671] [146/171] (812s left) vgem_basic (setversion) [194.001728] Starting subtest: setversion [194.002890] Subtest setversion: SUCCESS (0.000s) [194.051220] [147/171] (812s left) vgem_basic (create) [194.118202] Starting subtest: create [194.118819] Subtest create: SUCCESS (0.000s) [194.166649] [148/171] (812s left) vgem_basic (debugfs) [194.234860] Starting subtest: debugfs [194.235502] Subtest debugfs: SUCCESS (0.000s) [194.283706] [149/171] (811s left) vgem_basic (dmabuf-export) [194.351591] Starting subtest: dmabuf-export [194.363467] Subtest dmabuf-export: SUCCESS (0.009s) [194.462727] [150/171] (811s left) vgem_basic (dmabuf-fence) [194.551550] Starting subtest: dmabuf-fence [194.553352] Subtest dmabuf-fence: SUCCESS (0.001s) [194.601439] [151/171] (811s left) vgem_basic (dmabuf-fence-before) [194.668280] Starting subtest: dmabuf-fence-before [194.668889] Subtest dmabuf-fence-before: SUCCESS (0.000s) [194.719312] [152/171] (811s left) vgem_basic (dmabuf-mmap) [194.784741] Starting subtest: dmabuf-mmap [194.794722] Subtest dmabuf-mmap: SUCCESS (0.010s) [194.832973] [153/171] (811s left) vgem_basic (mmap) [194.901511] Starting subtest: mmap [194.908215] Subtest mmap: SUCCESS (0.007s) [194.949399] [154/171] (811s left) vgem_basic (second-client) [195.018298] Starting subtest: second-client [195.052140] Subtest second-client: SUCCESS (0.033s) [195.130839] [155/171] (811s left) vgem_basic (sysfs) [195.218271] Starting subtest: sysfs [195.218798] Subtest sysfs: SUCCESS (0.000s) [195.288161] [156/171] (811s left) core_hotunplug (unbind-rebind) [195.401920] Starting subtest: unbind-rebind [196.616627] Subtest unbind-rebind: SUCCESS (1.215s) [196.635283] [157/171] (809s left) vgem_basic (unload) [196.704477] Starting subtest: unload [225.705091] Subtest unload: SUCCESS (28.997s) [225.846704] [158/171] (780s left) i915_module_load (reload) [225.923282] Starting subtest: reload [228.317828] Subtest reload: SUCCESS (2.395s) [228.334601] [159/171] (778s left) gem_lmem_swapping (basic) [228.410609] Subtest basic: SKIP (0.000s) [228.442367] [160/171] (778s left) gem_lmem_swapping (parallel-random-engines) [228.503570] Subtest parallel-random-engines: SKIP (0.000s) [228.525652] [161/171] (777s left) gem_lmem_swapping (random-engines) [228.586860] Subtest random-engines: SKIP (0.000s) [228.608917] [162/171] (777s left) gem_lmem_swapping (verify-random) [228.669682] Subtest verify-random: SKIP (0.000s) [228.692669] [163/171] (777s left) i915_pm_rpm (module-reload) [230.793792] Starting subtest: module-reload [249.019285] Subtest module-reload: FAIL (18.170s) [249.536399] [164/171] (757s left) i915_selftest (live) [250.340794] Starting subtest: live [250.346081] Starting dynamic subtest: sanitycheck [250.910376] Dynamic subtest sanitycheck: SUCCESS (0.569s) [250.918300] Starting dynamic subtest: uncore [251.464458] Dynamic subtest uncore: SUCCESS (0.553s) [251.470859] Starting dynamic subtest: workarounds [252.281390] Dynamic subtest workarounds: SUCCESS (0.816s) [252.287180] Starting dynamic subtest: gt_engines [253.424381] Dynamic subtest gt_engines: SUCCESS (1.142s) [253.431995] Starting dynamic subtest: gt_timelines [262.290480] Dynamic subtest gt_timelines: SUCCESS (8.865s) [262.300537] Starting dynamic subtest: gt_contexts [262.987342] Dynamic subtest gt_contexts: SUCCESS (0.696s) [262.994983] Starting dynamic subtest: gt_lrc [266.574264] Dynamic subtest gt_lrc: SUCCESS (3.586s) [266.582744] Starting dynamic subtest: gt_mocs [267.219496] Dynamic subtest gt_mocs: SUCCESS (0.644s) [267.229145] Starting dynamic subtest: gt_pm [273.667398] Dynamic subtest gt_pm: SUCCESS (6.447s) [273.674656] Starting dynamic subtest: gt_heartbeat [274.408418] Dynamic subtest gt_heartbeat: SUCCESS (0.740s) [274.415085] Starting dynamic subtest: gt_tlb [276.041420] Dynamic subtest gt_tlb: SUCCESS (1.632s) [276.049209] Starting dynamic subtest: requests [284.060423] Dynamic subtest requests: SUCCESS (8.018s) [284.067524] Starting dynamic subtest: migrate [287.304396] Dynamic subtest migrate: SUCCESS (3.243s) [287.309826] Starting dynamic subtest: active [287.879326] Dynamic subtest active: SUCCESS (0.574s) [287.886120] Starting dynamic subtest: objects [289.122365] Dynamic subtest objects: SUCCESS (1.242s) [289.129936] Starting dynamic subtest: mman [293.185442] Dynamic subtest mman: SUCCESS (4.062s) [293.195249] Starting dynamic subtest: dmabuf [293.808473] Dynamic subtest dmabuf: SUCCESS (0.622s) [293.817492] Starting dynamic subtest: vma [294.390424] Dynamic subtest vma: SUCCESS (0.581s) [294.398707] Starting dynamic subtest: coherency [296.519419] Dynamic subtest coherency: SUCCESS (2.128s) [296.525425] Starting dynamic subtest: gtt [304.604281] Dynamic subtest gtt: SUCCESS (8.084s) [304.612327] Starting dynamic subtest: gem [305.334392] Dynamic subtest gem: SUCCESS (0.729s) [305.341927] Starting dynamic subtest: evict [307.079496] Dynamic subtest evict: SUCCESS (1.744s) [307.087654] Starting dynamic subtest: hugepages [314.174302] Dynamic subtest hugepages: SUCCESS (7.094s) [314.183903] Starting dynamic subtest: gem_contexts [329.413360] Dynamic subtest gem_contexts: SUCCESS (15.238s) [329.420711] Starting dynamic subtest: client [330.025536] Dynamic subtest client: SUCCESS (0.611s) [330.032036] Starting dynamic subtest: gem_migrate [330.586578] Dynamic subtest gem_migrate: SUCCESS (0.560s) [330.593254] Starting dynamic subtest: reset [331.974399] Dynamic subtest reset: SUCCESS (1.387s) [331.983462] Starting dynamic subtest: memory_region [332.541377] Dynamic subtest memory_region: SUCCESS (0.566s) [332.548163] Starting dynamic subtest: hangcheck [361.721596] Dynamic subtest hangcheck: SUCCESS (29.179s) [361.729360] Starting dynamic subtest: execlists [374.488442] Dynamic subtest execlists: SUCCESS (12.766s) [374.495473] Starting dynamic subtest: ring_submission [375.065459] Dynamic subtest ring_submission: SUCCESS (0.576s) [375.074702] Starting dynamic subtest: perf [375.688656] Dynamic subtest perf: SUCCESS (0.622s) [375.695602] Starting dynamic subtest: slpc [376.273608] Dynamic subtest slpc: SUCCESS (0.584s) [376.281168] Starting dynamic subtest: guc [376.874384] Dynamic subtest guc: SUCCESS (0.600s) [376.883321] Starting dynamic subtest: guc_multi_lrc [377.458558] Dynamic subtest guc_multi_lrc: SUCCESS (0.583s) [377.467255] Starting dynamic subtest: guc_hang [378.000328] Dynamic subtest guc_hang: SUCCESS (0.541s) [378.008830] Starting dynamic subtest: late_gt_pm [378.596389] Dynamic subtest late_gt_pm: SUCCESS (0.595s) [378.597048] Subtest live: SUCCESS (128.257s) [378.799100] [165/171] (627s left) dmabuf (all-tests) [378.881671] Starting subtest: all-tests [378.883116] Starting dynamic subtest: sanitycheck [378.955802] Dynamic subtest sanitycheck: SUCCESS (0.073s) [378.977279] Starting dynamic subtest: dma_fence [379.144129] Dynamic subtest dma_fence: SUCCESS (0.187s) [379.155547] Starting dynamic subtest: dma_fence_chain [390.183433] Dynamic subtest dma_fence_chain: SUCCESS (11.038s) [390.200488] Starting dynamic subtest: dma_fence_unwrap [390.245746] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s) [390.265495] Starting dynamic subtest: dma_resv [390.333702] Dynamic subtest dma_resv: SUCCESS (0.085s) [390.335391] Subtest all-tests: SUCCESS (11.453s) [390.368409] [166/171] (616s left) i915_suspend (basic-s2idle-without-i915) [390.445407] Starting subtest: basic-s2idle-without-i915 [408.876079] Subtest basic-s2idle-without-i915: SUCCESS (3.585s) [414.276941] [167/171] (612s left) i915_suspend (basic-s3-without-i915) [414.340392] Starting subtest: basic-s3-without-i915 [433.533648] Subtest basic-s3-without-i915: SUCCESS (4.489s) [436.930414] [168/171] (607s left) gem_exec_suspend (basic-s0) [437.010364] Starting subtest: basic-S0 [437.010954] Starting dynamic subtest: smem [454.872788] Dynamic subtest smem: SUCCESS (2.809s) [454.873337] Subtest basic-S0: SUCCESS (2.810s) [461.763759] [169/171] (604s left) gem_exec_suspend (basic-s3) [461.834446] Starting subtest: basic-S3 [461.835945] Starting dynamic subtest: smem [480.623783] Dynamic subtest smem: SUCCESS (4.592s) [480.624844] Subtest basic-S3: SUCCESS (4.593s) [483.760544] [170/171] (599s left) kms_chamelium_hpd (common-hpd-after-suspend) [484.091973] Subtest common-hpd-after-suspend: SKIP (0.000s) [484.304749] [171/171] (598s left) kms_pipe_crc_basic (suspend-read-crc) [484.561093] Starting subtest: suspend-read-crc [484.563062] Starting dynamic subtest: pipe-A-DP-1 [511.631934] Dynamic subtest pipe-A-DP-1: SUCCESS (11.170s) [511.650602] Starting dynamic subtest: pipe-B-DP-1 [531.245249] Dynamic subtest pipe-B-DP-1: SUCCESS (3.989s) [531.255689] Starting dynamic subtest: pipe-C-DP-1 [550.322257] Dynamic subtest pipe-C-DP-1: SUCCESS (4.178s) [550.322753] Subtest suspend-read-crc: SUCCESS (19.344s) [554.684836] Closing watchdogs Done.