[44.552322] Initializing watchdogs [44.552396] /dev/watchdog0 [44.557322] [001/171] (960s left) i915_module_load (load) [44.745218] Starting subtest: load [45.659671] Subtest load: SUCCESS (0.914s) [45.677747] [002/171] (959s left) core_auth (basic-auth) [45.760092] Starting subtest: basic-auth [45.761880] Subtest basic-auth: SUCCESS (0.000s) [45.820441] [003/171] (959s left) debugfs_test (read_all_entries) [45.880877] Starting subtest: read_all_entries [45.926361] Subtest read_all_entries: SUCCESS (0.045s) [46.038175] [004/171] (959s left) debugfs_test (basic-hwmon) [46.096361] Starting subtest: basic-hwmon [46.099587] Subtest basic-hwmon: SKIP (0.000s) [46.205458] [005/171] (958s left) fbdev (eof) [46.276170] Starting subtest: eof [46.277829] Subtest eof: SUCCESS (0.000s) [46.320141] [006/171] (958s left) fbdev (info) [46.375875] Starting subtest: info [46.377574] Subtest info: SUCCESS (0.000s) [46.441020] [007/171] (958s left) fbdev (nullptr) [46.509524] Starting subtest: nullptr [46.511236] Subtest nullptr: SUCCESS (0.000s) [46.555886] [008/171] (958s left) fbdev (read) [46.626176] Starting subtest: read [46.845365] Subtest read: SUCCESS (0.219s) [46.886951] [009/171] (958s left) fbdev (write) [46.959584] Starting subtest: write [47.070131] Subtest write: SUCCESS (0.111s) [47.112240] [010/171] (958s left) gem_basic (bad-close) [47.166436] Starting subtest: bad-close [47.169549] Subtest bad-close: SUCCESS (0.000s) [47.223758] [011/171] (957s left) gem_basic (create-close) [47.285699] Starting subtest: create-close [47.289073] Subtest create-close: SUCCESS (0.000s) [47.358319] [012/171] (957s left) gem_basic (create-fd-close) [47.441616] Starting subtest: create-fd-close [47.444871] Subtest create-fd-close: SUCCESS (0.000s) [47.530112] [013/171] (957s left) gem_busy (busy@all-engines) [47.634827] Starting subtest: busy [47.636104] Starting dynamic subtest: all-engines [47.653104] Dynamic subtest all-engines: SUCCESS (0.020s) [47.654662] Subtest busy: SUCCESS (0.020s) [48.031328] [014/171] (957s left) gem_close_race (basic-process) [48.093765] Starting subtest: basic-process [48.153886] Subtest basic-process: SUCCESS (0.060s) [48.338448] [015/171] (956s left) gem_close_race (basic-threads) [48.409026] Starting subtest: basic-threads [49.616510] Subtest basic-threads: SUCCESS (1.207s) [49.817229] [016/171] (955s left) gem_ctx_create (basic) [49.914173] Starting subtest: basic [49.915954] Subtest basic: SUCCESS (0.000s) [50.089264] [017/171] (955s left) gem_ctx_create (basic-files) [50.156523] Starting subtest: basic-files [52.165941] Subtest basic-files: SUCCESS (2.010s) [52.398536] [018/171] (952s left) gem_ctx_exec (basic) [52.470130] Starting subtest: basic [52.473076] Subtest basic: SUCCESS (0.002s) [52.554475] [019/171] (952s left) gem_exec_basic (basic) [52.630941] Starting subtest: basic [52.632500] Starting dynamic subtest: rcs0-smem [52.634066] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.638987] Starting dynamic subtest: bcs0-smem [52.640711] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [52.645419] Starting dynamic subtest: vcs0-smem [52.647214] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.651801] Starting dynamic subtest: vecs0-smem [52.653464] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.655220] Subtest basic: SUCCESS (0.003s) [52.879424] [020/171] (952s left) gem_exec_create (basic) [52.956226] Starting subtest: basic [52.957811] Starting dynamic subtest: smem [54.987022] Dynamic subtest smem: SUCCESS (2.031s) [54.988751] Subtest basic: SUCCESS (2.031s) [55.159969] [021/171] (950s left) gem_exec_fence (basic-busy) [55.349201] Starting subtest: basic-busy [55.350952] Starting dynamic subtest: rcs0 [55.364093] Dynamic subtest rcs0: SUCCESS (0.027s) [55.371439] Starting dynamic subtest: bcs0 [55.391780] Dynamic subtest bcs0: SUCCESS (0.028s) [55.398108] Starting dynamic subtest: vcs0 [55.410932] Dynamic subtest vcs0: SUCCESS (0.019s) [55.420592] Starting dynamic subtest: vecs0 [55.443535] Dynamic subtest vecs0: SUCCESS (0.032s) [55.446113] Subtest basic-busy: SUCCESS (0.106s) [56.014915] [022/171] (949s left) gem_exec_fence (basic-wait) [56.216529] Starting subtest: basic-wait [56.219328] Starting dynamic subtest: rcs0 [56.263055] Dynamic subtest rcs0: SUCCESS (0.048s) [56.285065] Starting dynamic subtest: bcs0 [56.303287] Dynamic subtest bcs0: SUCCESS (0.040s) [56.324925] Starting dynamic subtest: vcs0 [56.343934] Dynamic subtest vcs0: SUCCESS (0.040s) [56.359356] Starting dynamic subtest: vecs0 [56.380711] Dynamic subtest vecs0: SUCCESS (0.037s) [56.383108] Subtest basic-wait: SUCCESS (0.166s) [56.905440] [023/171] (948s left) gem_exec_fence (basic-await) [57.103800] Starting subtest: basic-await [57.105284] Starting dynamic subtest: rcs0 [57.166233] Dynamic subtest rcs0: SUCCESS (0.067s) [57.176327] Starting dynamic subtest: bcs0 [57.244296] Dynamic subtest bcs0: SUCCESS (0.085s) [57.266075] Starting dynamic subtest: vcs0 [57.351093] Dynamic subtest vcs0: SUCCESS (0.099s) [57.357657] Starting dynamic subtest: vecs0 [57.413892] Dynamic subtest vecs0: SUCCESS (0.071s) [57.416665] Subtest basic-await: SUCCESS (0.322s) [57.941411] [024/171] (947s left) gem_exec_fence (nb-await) [58.171687] Starting subtest: nb-await [58.174688] Starting dynamic subtest: rcs0 [58.244432] Dynamic subtest rcs0: SUCCESS (0.065s) [58.253045] Starting dynamic subtest: bcs0 [58.292864] Dynamic subtest bcs0: SUCCESS (0.059s) [58.303191] Starting dynamic subtest: vcs0 [58.355526] Dynamic subtest vcs0: SUCCESS (0.061s) [58.377456] Starting dynamic subtest: vecs0 [58.428627] Dynamic subtest vecs0: SUCCESS (0.073s) [58.431796] Subtest nb-await: SUCCESS (0.259s) [58.977994] [025/171] (946s left) gem_exec_gttfill (basic) [59.039805] Starting subtest: basic [64.865153] Subtest basic: SUCCESS (5.651s) [65.060772] [026/171] (940s left) gem_exec_parallel (engines) [65.171131] Starting subtest: engines [65.172691] Starting dynamic subtest: basic [66.959579] Dynamic subtest basic: SUCCESS (1.788s) [66.972564] Starting dynamic subtest: contexts [69.300491] Dynamic subtest contexts: SUCCESS (2.309s) [69.306238] Starting dynamic subtest: fds [71.590904] Dynamic subtest fds: SUCCESS (2.322s) [71.596865] Starting dynamic subtest: userptr [73.667627] Dynamic subtest userptr: SUCCESS (2.076s) [73.669440] Subtest engines: SUCCESS (8.496s) [73.864245] [027/171] (931s left) gem_exec_store (basic) [73.946157] Starting subtest: basic [73.999013] Subtest basic: SUCCESS (0.054s) [74.198066] [028/171] (931s left) gem_flink_basic (bad-flink) [74.250944] Starting subtest: bad-flink [74.252577] Subtest bad-flink: SUCCESS (0.000s) [74.309271] [029/171] (931s left) gem_flink_basic (bad-open) [74.389107] Starting subtest: bad-open [74.390774] Subtest bad-open: SUCCESS (0.000s) [74.438277] [030/171] (931s left) gem_flink_basic (basic) [74.496138] Starting subtest: basic [74.498313] Subtest basic: SUCCESS (0.000s) [74.607292] [031/171] (931s left) gem_flink_basic (double-flink) [74.708835] Starting subtest: double-flink [74.710849] Subtest double-flink: SUCCESS (0.000s) [74.800423] [032/171] (931s left) gem_flink_basic (flink-lifetime) [74.860927] Starting subtest: flink-lifetime [74.862597] Subtest flink-lifetime: SUCCESS (0.001s) [74.950671] [033/171] (930s left) gem_huc_copy (huc-copy) [75.013526] Starting subtest: huc-copy [75.016913] Subtest huc-copy: SKIP (0.000s) [75.134118] [034/171] (930s left) gem_linear_blits (basic) [75.268722] Starting subtest: basic [75.273239] Subtest basic: SUCCESS (0.005s) [75.426685] [035/171] (930s left) gem_mmap (basic) [75.537573] Starting subtest: basic [75.546467] Subtest basic: SUCCESS (0.000s) [75.656876] [036/171] (930s left) gem_mmap_gtt (basic) [75.763992] Starting subtest: basic [75.765642] Subtest basic: SUCCESS (0.000s) [75.816969] [037/171] (930s left) gem_render_linear_blits (basic) [75.896173] Starting subtest: basic [75.917733] Subtest basic: SUCCESS (0.022s) [75.950096] [038/171] (930s left) gem_render_tiled_blits (basic) [76.008630] Starting subtest: basic [76.033838] Subtest basic: SUCCESS (0.025s) [76.066270] [039/171] (929s left) gem_ringfill (basic-all) [76.325185] Starting subtest: basic-all [77.472195] Subtest basic-all: SUCCESS (1.132s) [77.583756] [040/171] (928s left) gem_softpin (allocator-basic) [77.685240] Starting subtest: allocator-basic [77.760016] Subtest allocator-basic: SUCCESS (0.066s) [77.848275] [041/171] (928s left) gem_softpin (allocator-basic-reserve) [77.912214] Starting subtest: allocator-basic-reserve [77.982736] Subtest allocator-basic-reserve: SUCCESS (0.066s) [78.062334] [042/171] (927s left) gem_softpin (safe-alignment) [78.120642] Starting subtest: safe-alignment [78.128207] Subtest safe-alignment: SUCCESS (0.007s) [78.219862] [043/171] (927s left) gem_sync (basic-all) [78.300037] Starting subtest: basic-all [80.484236] Subtest basic-all: SUCCESS (2.069s) [80.547306] [044/171] (925s left) gem_sync (basic-each) [80.625522] Starting subtest: basic-each [82.795035] Subtest basic-each: SUCCESS (2.082s) [82.966733] [045/171] (923s left) gem_tiled_blits (basic) [83.287064] Starting subtest: basic [83.318163] Subtest basic: SUCCESS (0.036s) [83.496945] [046/171] (922s left) gem_tiled_fence_blits (basic) [83.845109] Starting subtest: basic [83.877721] Subtest basic: SUCCESS (0.008s) [84.026273] [047/171] (922s left) gem_tiled_pread_basic [84.490953] [048/171] (921s left) gem_wait (busy@all-engines) [84.753192] Starting subtest: busy [84.785384] Starting dynamic subtest: all-engines [85.264175] Dynamic subtest all-engines: SUCCESS (0.526s) [85.296160] Subtest busy: SUCCESS (0.526s) [85.456350] [049/171] (921s left) gem_wait (wait@all-engines) [85.648303] Starting subtest: wait [85.680266] Starting dynamic subtest: all-engines [86.685408] Dynamic subtest all-engines: SUCCESS (1.056s) [86.716900] Subtest wait: SUCCESS (1.056s) [86.897689] [050/171] (919s left) i915_getparams_basic (basic-eu-total) [87.041310] Starting subtest: basic-eu-total [87.109674] Subtest basic-eu-total: SUCCESS (0.000s) [87.222638] [051/171] (919s left) i915_getparams_basic (basic-subslice-total) [87.895128] Starting subtest: basic-subslice-total [87.901271] Subtest basic-subslice-total: SUCCESS (0.000s) [87.919407] [052/171] (919s left) i915_hangman (error-state-basic) [87.980341] Starting subtest: error-state-basic [87.987436] Subtest error-state-basic: SUCCESS (0.008s) [88.075435] [053/171] (918s left) i915_pciid [88.193674] [054/171] (918s left) kms_addfb_basic (addfb25-bad-modifier) [88.308615] Starting subtest: addfb25-bad-modifier [88.310233] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [88.472526] [055/171] (918s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [88.578250] Starting subtest: addfb25-framebuffer-vs-set-tiling [88.579856] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [88.739242] [056/171] (918s left) kms_addfb_basic (addfb25-modifier-no-flag) [88.844047] Starting subtest: addfb25-modifier-no-flag [88.845744] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [89.005535] [057/171] (918s left) kms_addfb_basic (addfb25-x-tiled-legacy) [89.109233] Starting subtest: addfb25-x-tiled-legacy [89.110648] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [89.271954] [058/171] (917s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [89.374940] Starting subtest: addfb25-x-tiled-mismatch-legacy [89.376510] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [89.556799] [059/171] (917s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [89.711949] Starting subtest: addfb25-yf-tiled-legacy [89.713495] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [89.839149] [060/171] (917s left) kms_addfb_basic (addfb25-y-tiled-legacy) [89.994184] Starting subtest: addfb25-y-tiled-legacy [89.995665] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [90.122967] [061/171] (916s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [90.275954] Starting subtest: addfb25-y-tiled-small-legacy [90.277433] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [90.406206] [062/171] (916s left) kms_addfb_basic (bad-pitch-0) [90.459741] Starting subtest: bad-pitch-0 [90.461186] Subtest bad-pitch-0: SUCCESS (0.000s) [90.688893] [063/171] (916s left) kms_addfb_basic (bad-pitch-1024) [90.741295] Starting subtest: bad-pitch-1024 [90.742720] Subtest bad-pitch-1024: SUCCESS (0.000s) [90.955683] [064/171] (916s left) kms_addfb_basic (bad-pitch-128) [91.009026] Starting subtest: bad-pitch-128 [91.010723] Subtest bad-pitch-128: SUCCESS (0.000s) [91.239272] [065/171] (915s left) kms_addfb_basic (bad-pitch-256) [91.293070] Starting subtest: bad-pitch-256 [91.294734] Subtest bad-pitch-256: SUCCESS (0.000s) [91.522530] [066/171] (915s left) kms_addfb_basic (bad-pitch-32) [91.575670] Starting subtest: bad-pitch-32 [91.577293] Subtest bad-pitch-32: SUCCESS (0.000s) [91.805327] [067/171] (915s left) kms_addfb_basic (bad-pitch-63) [91.857261] Starting subtest: bad-pitch-63 [91.858871] Subtest bad-pitch-63: SUCCESS (0.000s) [92.089538] [068/171] (915s left) kms_addfb_basic (bad-pitch-65536) [92.142945] Starting subtest: bad-pitch-65536 [92.144596] Subtest bad-pitch-65536: SUCCESS (0.000s) [92.373137] [069/171] (914s left) kms_addfb_basic (bad-pitch-999) [92.426361] Starting subtest: bad-pitch-999 [92.427883] Subtest bad-pitch-999: SUCCESS (0.000s) [92.655563] [070/171] (914s left) kms_addfb_basic (basic) [92.708056] Starting subtest: basic [92.709636] Subtest basic: SUCCESS (0.000s) [92.938765] [071/171] (914s left) kms_addfb_basic (basic-x-tiled-legacy) [93.142414] Starting subtest: basic-x-tiled-legacy [93.144047] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [93.221677] [072/171] (914s left) kms_addfb_basic (basic-y-tiled-legacy) [93.423390] Starting subtest: basic-y-tiled-legacy [93.425062] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [93.513513] [073/171] (913s left) kms_addfb_basic (bo-too-small) [93.616438] Starting subtest: bo-too-small [93.617906] Subtest bo-too-small: SUCCESS (0.000s) [93.788875] [074/171] (913s left) kms_addfb_basic (bo-too-small-due-to-tiling) [93.892053] Starting subtest: bo-too-small-due-to-tiling [93.893693] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [94.072252] [075/171] (913s left) kms_addfb_basic (clobberred-modifier) [94.125567] Starting subtest: clobberred-modifier [94.127288] Subtest clobberred-modifier: SUCCESS (0.000s) [94.355465] [076/171] (912s left) kms_addfb_basic (framebuffer-vs-set-tiling) [94.557251] Starting subtest: framebuffer-vs-set-tiling [94.558848] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [94.639138] [077/171] (912s left) kms_addfb_basic (invalid-get-prop) [94.841300] Starting subtest: invalid-get-prop [94.842896] Subtest invalid-get-prop: SUCCESS (0.000s) [94.922423] [078/171] (912s left) kms_addfb_basic (invalid-get-prop-any) [95.124214] Starting subtest: invalid-get-prop-any [95.125721] Subtest invalid-get-prop-any: SUCCESS (0.000s) [95.206305] [079/171] (912s left) kms_addfb_basic (invalid-set-prop) [95.408795] Starting subtest: invalid-set-prop [95.410631] Subtest invalid-set-prop: SUCCESS (0.000s) [95.472192] [080/171] (911s left) kms_addfb_basic (invalid-set-prop-any) [95.674251] Starting subtest: invalid-set-prop-any [95.675732] Subtest invalid-set-prop-any: SUCCESS (0.000s) [95.755758] [081/171] (911s left) kms_addfb_basic (no-handle) [95.809041] Starting subtest: no-handle [95.810693] Subtest no-handle: SUCCESS (0.000s) [96.039435] [082/171] (911s left) kms_addfb_basic (size-max) [96.143903] Starting subtest: size-max [96.145460] Subtest size-max: SUCCESS (0.000s) [96.322672] [083/171] (911s left) kms_addfb_basic (small-bo) [96.427068] Starting subtest: small-bo [96.428617] Subtest small-bo: SUCCESS (0.000s) [96.605770] [084/171] (910s left) kms_addfb_basic (tile-pitch-mismatch) [96.807852] Starting subtest: tile-pitch-mismatch [96.809408] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [96.889577] [085/171] (910s left) kms_addfb_basic (too-high) [96.994415] Starting subtest: too-high [96.995975] Subtest too-high: SUCCESS (0.000s) [97.172447] [086/171] (910s left) kms_addfb_basic (too-wide) [97.277685] Starting subtest: too-wide [97.279117] Subtest too-wide: SUCCESS (0.000s) [97.455810] [087/171] (909s left) kms_addfb_basic (unused-handle) [97.509186] Starting subtest: unused-handle [97.510719] Subtest unused-handle: SUCCESS (0.000s) [97.739303] [088/171] (909s left) kms_addfb_basic (unused-modifier) [97.792185] Starting subtest: unused-modifier [97.793640] Subtest unused-modifier: SUCCESS (0.000s) [98.022401] [089/171] (909s left) kms_addfb_basic (unused-offsets) [98.075651] Starting subtest: unused-offsets [98.077081] Subtest unused-offsets: SUCCESS (0.000s) [98.305920] [090/171] (909s left) kms_addfb_basic (unused-pitches) [98.359052] Starting subtest: unused-pitches [98.360490] Subtest unused-pitches: SUCCESS (0.000s) [98.572393] [091/171] (908s left) kms_busy (basic) [98.683265] Starting subtest: basic [98.684795] Starting dynamic subtest: flip [99.112490] Dynamic subtest flip: SUCCESS (0.430s) [99.118412] Starting dynamic subtest: modeset [99.442381] Dynamic subtest modeset: SUCCESS (0.329s) [99.443959] Subtest basic: SUCCESS (0.760s) [99.553514] [092/171] (907s left) kms_chamelium_hpd (dp-hpd-fast) [99.679229] Subtest dp-hpd-fast: SKIP (0.000s) [99.725559] [093/171] (907s left) kms_chamelium_edid (dp-edid-read) [99.855346] Subtest dp-edid-read: SKIP (0.000s) [99.900219] [094/171] (907s left) kms_chamelium_frames (dp-crc-fast) [100.028380] Subtest dp-crc-fast: SKIP (0.000s) [100.074538] [095/171] (907s left) kms_chamelium_hpd (hdmi-hpd-fast) [100.203508] Subtest hdmi-hpd-fast: SKIP (0.000s) [100.249774] [096/171] (907s left) kms_chamelium_edid (hdmi-edid-read) [100.379196] Subtest hdmi-edid-read: SKIP (0.000s) [100.424326] [097/171] (907s left) kms_chamelium_frames (hdmi-crc-fast) [100.554628] Subtest hdmi-crc-fast: SKIP (0.000s) [100.601850] [098/171] (906s left) kms_chamelium_hpd (vga-hpd-fast) [100.729337] Subtest vga-hpd-fast: SKIP (0.000s) [100.775548] [099/171] (906s left) kms_chamelium_edid (vga-edid-read) [100.904624] Subtest vga-edid-read: SKIP (0.000s) [100.950935] [100/171] (906s left) kms_prop_blob (basic) [101.005102] Starting subtest: basic [101.006633] Subtest basic: SUCCESS (0.000s) [101.053830] [101/171] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [101.160136] Starting subtest: basic-busy-flip-before-cursor-atomic [101.163115] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [101.220189] [102/171] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [101.324995] Starting subtest: basic-busy-flip-before-cursor-legacy [101.328309] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [101.386670] [103/171] (906s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [101.490336] Starting subtest: basic-flip-after-cursor-atomic [102.411422] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.920s) [102.508828] [104/171] (905s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [102.611196] Starting subtest: basic-flip-after-cursor-legacy [103.516694] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.904s) [103.618577] [105/171] (904s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [103.722605] Starting subtest: basic-flip-after-cursor-varying-size [104.660396] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.937s) [104.763193] [106/171] (902s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [104.867308] Starting subtest: basic-flip-before-cursor-atomic [105.770784] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.903s) [105.865861] [107/171] (901s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [105.970487] Starting subtest: basic-flip-before-cursor-legacy [106.890833] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.920s) [106.987367] [108/171] (900s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [107.090486] Starting subtest: basic-flip-before-cursor-varying-size [108.012808] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.920s) [108.116254] [109/171] (899s left) kms_flip (basic-flip-vs-dpms) [108.208179] Starting subtest: basic-flip-vs-dpms [108.209544] Starting dynamic subtest: A-HDMI-A1 [109.044380] Dynamic subtest A-HDMI-A1: SUCCESS (0.835s) [109.050428] Starting dynamic subtest: B-HDMI-A1 [109.845382] Dynamic subtest B-HDMI-A1: SUCCESS (0.800s) [109.852054] Starting dynamic subtest: C-HDMI-A1 [110.648387] Dynamic subtest C-HDMI-A1: SUCCESS (0.803s) [110.650009] Subtest basic-flip-vs-dpms: SUCCESS (2.442s) [110.761518] [110/171] (896s left) kms_flip (basic-flip-vs-modeset) [110.858756] Starting subtest: basic-flip-vs-modeset [110.860467] Starting dynamic subtest: A-HDMI-A1 [111.651729] Dynamic subtest A-HDMI-A1: SUCCESS (0.791s) [111.657935] Starting dynamic subtest: B-HDMI-A1 [112.476756] Dynamic subtest B-HDMI-A1: SUCCESS (0.825s) [112.482727] Starting dynamic subtest: C-HDMI-A1 [113.302653] Dynamic subtest C-HDMI-A1: SUCCESS (0.826s) [113.304066] Subtest basic-flip-vs-modeset: SUCCESS (2.447s) [113.414855] [111/171] (894s left) kms_flip (basic-flip-vs-wf_vblank) [113.511150] Starting subtest: basic-flip-vs-wf_vblank [113.512528] Starting dynamic subtest: A-HDMI-A1 [114.603061] Dynamic subtest A-HDMI-A1: SUCCESS (1.091s) [114.609124] Starting dynamic subtest: B-HDMI-A1 [115.688054] Dynamic subtest B-HDMI-A1: SUCCESS (1.084s) [115.695123] Starting dynamic subtest: C-HDMI-A1 [116.756505] Dynamic subtest C-HDMI-A1: SUCCESS (1.068s) [116.758053] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.249s) [116.874948] [112/171] (890s left) kms_flip (basic-plain-flip) [116.967967] Starting subtest: basic-plain-flip [116.969424] Starting dynamic subtest: A-HDMI-A1 [117.779739] Dynamic subtest A-HDMI-A1: SUCCESS (0.812s) [117.785911] Starting dynamic subtest: B-HDMI-A1 [118.564185] Dynamic subtest B-HDMI-A1: SUCCESS (0.784s) [118.571179] Starting dynamic subtest: C-HDMI-A1 [119.350553] Dynamic subtest C-HDMI-A1: SUCCESS (0.786s) [119.352259] Subtest basic-plain-flip: SUCCESS (2.387s) [119.467951] [113/171] (888s left) kms_force_connector_basic (force-connector-state) [119.622296] Starting subtest: force-connector-state [119.883022] Subtest force-connector-state: SUCCESS (0.259s) [120.289441] [114/171] (887s left) kms_force_connector_basic (force-edid) [120.441800] Starting subtest: force-edid [120.578528] Subtest force-edid: SUCCESS (0.137s) [120.772480] [115/171] (887s left) kms_force_connector_basic (force-load-detect) [120.925778] Starting subtest: force-load-detect [120.928955] Subtest force-load-detect: SKIP (0.000s) [121.122567] [116/171] (886s left) kms_force_connector_basic (prune-stale-modes) [121.274354] Starting subtest: prune-stale-modes [121.409515] Subtest prune-stale-modes: SUCCESS (0.135s) [121.606513] [117/171] (886s left) kms_frontbuffer_tracking (basic) [121.718115] Starting subtest: basic [124.025198] Subtest basic: SUCCESS (2.312s) [124.106137] [118/171] (883s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [124.212604] Starting subtest: compare-crc-sanitycheck [124.214111] Starting dynamic subtest: pipe-A-HDMI-A-1 [124.532044] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.319s) [124.538186] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.817928] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.286s) [124.824229] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.104623] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.286s) [125.106207] Subtest compare-crc-sanitycheck: SUCCESS (0.892s) [125.213691] [119/171] (882s left) kms_pipe_crc_basic (hang-read-crc) [125.318489] Starting subtest: hang-read-crc [125.319959] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.115818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.797s) [126.122017] Starting dynamic subtest: pipe-B-HDMI-A-1 [126.888925] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.774s) [126.896812] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.651807] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.762s) [127.653460] Subtest hang-read-crc: SUCCESS (2.333s) [127.730197] [120/171] (880s left) kms_pipe_crc_basic (nonblocking-crc) [127.836847] Starting subtest: nonblocking-crc [127.838678] Starting dynamic subtest: pipe-A-HDMI-A-1 [128.321806] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.484s) [128.327985] Starting dynamic subtest: pipe-B-HDMI-A-1 [128.762722] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.441s) [128.768915] Starting dynamic subtest: pipe-C-HDMI-A-1 [129.206783] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.444s) [129.208328] Subtest nonblocking-crc: SUCCESS (1.370s) [129.283832] [121/171] (878s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [129.387319] Starting subtest: nonblocking-crc-frame-sequence [129.388824] Starting dynamic subtest: pipe-A-HDMI-A-1 [129.892793] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.503s) [129.899052] Starting dynamic subtest: pipe-B-HDMI-A-1 [130.335773] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.443s) [130.342159] Starting dynamic subtest: pipe-C-HDMI-A-1 [130.796217] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.461s) [130.797799] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.408s) [130.931101] [122/171] (876s left) kms_pipe_crc_basic (read-crc) [131.037961] Starting subtest: read-crc [131.039514] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.454481] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s) [131.460490] Starting dynamic subtest: pipe-B-HDMI-A-1 [131.831612] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.375s) [131.837620] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.206675] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.376s) [132.208221] Subtest read-crc: SUCCESS (1.170s) [132.285301] [123/171] (875s left) kms_pipe_crc_basic (read-crc-frame-sequence) [132.390299] Starting subtest: read-crc-frame-sequence [132.391699] Starting dynamic subtest: pipe-A-HDMI-A-1 [132.809087] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.419s) [132.815418] Starting dynamic subtest: pipe-B-HDMI-A-1 [133.201658] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.392s) [133.208890] Starting dynamic subtest: pipe-C-HDMI-A-1 [133.585265] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.382s) [133.587130] Subtest read-crc-frame-sequence: SUCCESS (1.194s) [133.662465] [124/171] (874s left) kms_psr (primary_page_flip) [133.717502] Subtest primary_page_flip: SKIP (0.000s) [133.740835] [125/171] (874s left) kms_psr (cursor_plane_move) [133.795313] Subtest cursor_plane_move: SKIP (0.000s) [133.823495] [126/171] (874s left) kms_psr (sprite_plane_onoff) [133.878138] Subtest sprite_plane_onoff: SKIP (0.000s) [133.906359] [127/171] (874s left) kms_psr (primary_mmap_gtt) [133.965273] Subtest primary_mmap_gtt: SKIP (0.000s) [133.990223] [128/171] (874s left) kms_setmode (basic-clone-single-crtc) [134.048341] Starting subtest: basic-clone-single-crtc [134.053078] Subtest basic-clone-single-crtc: SKIP (0.000s) [134.115987] [129/171] (873s left) i915_pm_backlight (basic-brightness) [134.235530] Subtest basic-brightness: SKIP (0.000s) [134.257638] [130/171] (873s left) i915_pm_rpm (basic-pci-d3-state) [135.656531] Starting subtest: basic-pci-d3-state [136.092351] Subtest basic-pci-d3-state: SUCCESS (0.435s) [136.354342] [131/171] (871s left) i915_pm_rpm (basic-rte) [136.407968] Starting subtest: basic-rte [138.167442] Subtest basic-rte: SUCCESS (1.758s) [138.749202] [132/171] (869s left) i915_pm_rps (basic-api) [138.806755] Starting subtest: basic-api [138.810085] Subtest basic-api: SUCCESS (0.002s) [138.865430] [133/171] (869s left) prime_self_import (basic-llseek-bad) [138.926089] Starting subtest: basic-llseek-bad [138.927918] Subtest basic-llseek-bad: SUCCESS (0.001s) [139.002480] [134/171] (869s left) prime_self_import (basic-llseek-size) [139.058564] Starting subtest: basic-llseek-size [139.059894] Subtest basic-llseek-size: SUCCESS (0.001s) [139.140683] [135/171] (868s left) prime_self_import (basic-with_fd_dup) [139.223683] Starting subtest: basic-with_fd_dup [139.225037] Subtest basic-with_fd_dup: SUCCESS (0.002s) [139.306294] [136/171] (868s left) prime_self_import (basic-with_one_bo) [139.364842] Starting subtest: basic-with_one_bo [139.366351] Subtest basic-with_one_bo: SUCCESS (0.002s) [139.409608] [137/171] (868s left) prime_self_import (basic-with_one_bo_two_files) [139.462270] Starting subtest: basic-with_one_bo_two_files [139.463849] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [139.537861] [138/171] (868s left) prime_self_import (basic-with_two_bos) [139.619056] Starting subtest: basic-with_two_bos [139.620676] Subtest basic-with_two_bos: SUCCESS (0.002s) [139.713358] [139/171] (868s left) prime_vgem (basic-fence-flip) [139.821891] Starting subtest: basic-fence-flip [140.201995] Subtest basic-fence-flip: SUCCESS (0.379s) [140.283419] [140/171] (867s left) prime_vgem (basic-fence-mmap) [140.355826] Starting subtest: basic-fence-mmap [140.372419] Subtest basic-fence-mmap: SUCCESS (0.017s) [140.457140] [141/171] (867s left) prime_vgem (basic-fence-read) [140.521934] Starting subtest: basic-fence-read [140.549633] Subtest basic-fence-read: SUCCESS (0.028s) [140.677887] [142/171] (867s left) prime_vgem (basic-gtt) [140.783936] Starting subtest: basic-gtt [140.792161] Subtest basic-gtt: SUCCESS (0.008s) [140.878869] [143/171] (867s left) prime_vgem (basic-read) [140.955677] Starting subtest: basic-read [140.968667] Subtest basic-read: SUCCESS (0.013s) [141.036641] [144/171] (867s left) prime_vgem (basic-write) [141.121607] Starting subtest: basic-write [141.136818] Subtest basic-write: SUCCESS (0.015s) [141.224216] [145/171] (867s left) prime_vgem (basic-userptr) [141.288802] Starting subtest: basic-userptr [141.295344] Subtest basic-userptr: SKIP (0.005s) [141.374342] [146/171] (866s left) vgem_basic (setversion) [141.452138] Starting subtest: setversion [141.455544] Subtest setversion: SUCCESS (0.000s) [141.497556] [147/171] (866s left) vgem_basic (create) [141.552780] Starting subtest: create [141.554428] Subtest create: SUCCESS (0.000s) [141.598470] [148/171] (866s left) vgem_basic (debugfs) [141.668244] Starting subtest: debugfs [141.669803] Subtest debugfs: SUCCESS (0.000s) [141.716135] [149/171] (866s left) vgem_basic (dmabuf-export) [141.785063] Starting subtest: dmabuf-export [141.799235] Subtest dmabuf-export: SUCCESS (0.014s) [141.928857] [150/171] (866s left) vgem_basic (dmabuf-fence) [142.001718] Starting subtest: dmabuf-fence [142.003345] Subtest dmabuf-fence: SUCCESS (0.000s) [142.050060] [151/171] (866s left) vgem_basic (dmabuf-fence-before) [142.118419] Starting subtest: dmabuf-fence-before [142.120157] Subtest dmabuf-fence-before: SUCCESS (0.000s) [142.169864] [152/171] (866s left) vgem_basic (dmabuf-mmap) [142.251531] Starting subtest: dmabuf-mmap [142.262293] Subtest dmabuf-mmap: SUCCESS (0.011s) [142.297409] [153/171] (866s left) vgem_basic (mmap) [142.368141] Starting subtest: mmap [142.375179] Subtest mmap: SUCCESS (0.007s) [142.414978] [154/171] (866s left) vgem_basic (second-client) [142.484867] Starting subtest: second-client [142.534816] Subtest second-client: SUCCESS (0.050s) [142.629141] [155/171] (865s left) vgem_basic (sysfs) [142.719190] Starting subtest: sysfs [142.720934] Subtest sysfs: SUCCESS (0.000s) [142.764922] [156/171] (865s left) core_hotunplug (unbind-rebind) [142.835186] Starting subtest: unbind-rebind [143.647368] Subtest unbind-rebind: SUCCESS (0.812s) [143.680121] [157/171] (864s left) vgem_basic (unload) [143.738907] Starting subtest: unload [172.463053] Subtest unload: SUCCESS (28.724s) [172.546146] [158/171] (836s left) i915_module_load (reload) [172.601786] Starting subtest: reload [174.148714] Subtest reload: SUCCESS (1.546s) [174.166711] [159/171] (834s left) gem_lmem_swapping (basic) [174.246694] Subtest basic: SKIP (0.000s) [174.273394] [160/171] (834s left) gem_lmem_swapping (parallel-random-engines) [174.330848] Subtest parallel-random-engines: SKIP (0.000s) [174.356619] [161/171] (834s left) gem_lmem_swapping (random-engines) [174.414890] Subtest random-engines: SKIP (0.000s) [174.439778] [162/171] (834s left) gem_lmem_swapping (verify-random) [174.498897] Subtest verify-random: SKIP (0.000s) [174.522573] [163/171] (834s left) i915_pm_rpm (module-reload) [176.431701] Starting subtest: module-reload [183.824027] Subtest module-reload: SUCCESS (7.394s) [183.836035] [164/171] (824s left) i915_selftest (live) [183.934842] Starting subtest: live [183.937033] Starting dynamic subtest: sanitycheck [184.388254] Dynamic subtest sanitycheck: SUCCESS (0.453s) [184.393409] Starting dynamic subtest: uncore [184.838254] Dynamic subtest uncore: SUCCESS (0.449s) [184.843992] Starting dynamic subtest: workarounds [185.486248] Dynamic subtest workarounds: SUCCESS (0.648s) [185.491083] Starting dynamic subtest: gt_engines [186.397382] Dynamic subtest gt_engines: SUCCESS (0.910s) [186.402264] Starting dynamic subtest: gt_timelines [192.672368] Dynamic subtest gt_timelines: SUCCESS (6.275s) [192.677445] Starting dynamic subtest: gt_contexts [193.190286] Dynamic subtest gt_contexts: SUCCESS (0.517s) [193.195285] Starting dynamic subtest: gt_lrc [196.039261] Dynamic subtest gt_lrc: SUCCESS (2.848s) [196.044260] Starting dynamic subtest: gt_mocs [196.551467] Dynamic subtest gt_mocs: SUCCESS (0.512s) [196.556433] Starting dynamic subtest: gt_pm [198.878463] Dynamic subtest gt_pm: SUCCESS (2.326s) [198.883605] Starting dynamic subtest: gt_heartbeat [199.429436] Dynamic subtest gt_heartbeat: SUCCESS (0.551s) [199.434504] Starting dynamic subtest: requests [206.155520] Dynamic subtest requests: SUCCESS (6.725s) [206.160675] Starting dynamic subtest: migrate [209.494295] Dynamic subtest migrate: SUCCESS (3.339s) [209.499308] Starting dynamic subtest: active [209.967430] Dynamic subtest active: SUCCESS (0.473s) [209.972504] Starting dynamic subtest: objects [211.131595] Dynamic subtest objects: SUCCESS (1.163s) [211.136753] Starting dynamic subtest: mman [215.122456] Dynamic subtest mman: SUCCESS (3.990s) [215.127734] Starting dynamic subtest: dmabuf [215.621606] Dynamic subtest dmabuf: SUCCESS (0.498s) [215.626949] Starting dynamic subtest: vma [216.083319] Dynamic subtest vma: SUCCESS (0.462s) [216.088209] Starting dynamic subtest: coherency [217.876479] Dynamic subtest coherency: SUCCESS (1.793s) [217.881642] Starting dynamic subtest: gtt [227.650378] Dynamic subtest gtt: SUCCESS (9.773s) [227.655718] Starting dynamic subtest: gem [228.164435] Dynamic subtest gem: SUCCESS (0.514s) [228.169750] Starting dynamic subtest: evict [229.423406] Dynamic subtest evict: SUCCESS (1.259s) [229.428556] Starting dynamic subtest: hugepages [234.933441] Dynamic subtest hugepages: SUCCESS (5.510s) [234.938399] Starting dynamic subtest: gem_contexts [247.254352] Dynamic subtest gem_contexts: SUCCESS (12.320s) [247.259466] Starting dynamic subtest: client [247.732413] Dynamic subtest client: SUCCESS (0.478s) [247.737621] Starting dynamic subtest: gem_migrate [248.178269] Dynamic subtest gem_migrate: SUCCESS (0.445s) [248.183422] Starting dynamic subtest: reset [248.964643] Dynamic subtest reset: SUCCESS (0.786s) [248.969935] Starting dynamic subtest: memory_region [249.425490] Dynamic subtest memory_region: SUCCESS (0.460s) [249.430636] Starting dynamic subtest: hangcheck [272.930523] Dynamic subtest hangcheck: SUCCESS (23.504s) [272.935916] Starting dynamic subtest: execlists [281.351497] Dynamic subtest execlists: SUCCESS (8.421s) [281.356895] Starting dynamic subtest: ring_submission [281.858026] Dynamic subtest ring_submission: SUCCESS (0.506s) [281.867726] Starting dynamic subtest: perf [282.417592] Dynamic subtest perf: SUCCESS (0.559s) [282.422864] Starting dynamic subtest: slpc [282.871329] Dynamic subtest slpc: SUCCESS (0.453s) [282.876513] Starting dynamic subtest: guc [283.300296] Dynamic subtest guc: SUCCESS (0.429s) [283.305270] Starting dynamic subtest: guc_multi_lrc [283.742377] Dynamic subtest guc_multi_lrc: SUCCESS (0.442s) [283.747422] Starting dynamic subtest: guc_hang [284.234756] Dynamic subtest guc_hang: SUCCESS (0.492s) [284.240172] Starting dynamic subtest: late_gt_pm [284.698260] Dynamic subtest late_gt_pm: SUCCESS (0.463s) [284.699713] Subtest live: SUCCESS (100.764s) [284.757132] [165/171] (723s left) dmabuf (all-tests) [284.821974] Starting subtest: all-tests [284.824066] Starting dynamic subtest: sanitycheck [284.852846] Dynamic subtest sanitycheck: SUCCESS (0.031s) [284.858083] Starting dynamic subtest: dma_fence [284.978065] Dynamic subtest dma_fence: SUCCESS (0.125s) [284.982942] Starting dynamic subtest: dma_fence_chain [296.765330] Dynamic subtest dma_fence_chain: SUCCESS (11.787s) [296.770759] Starting dynamic subtest: dma_fence_unwrap [296.791715] Dynamic subtest dma_fence_unwrap: SUCCESS (0.027s) [296.797574] Starting dynamic subtest: dma_resv [296.820839] Dynamic subtest dma_resv: SUCCESS (0.029s) [296.822397] Subtest all-tests: SUCCESS (11.999s) [296.835304] [166/171] (711s left) i915_suspend (basic-s2idle-without-i915) [296.905745] Starting subtest: basic-s2idle-without-i915 [314.445319] Subtest basic-s2idle-without-i915: SUCCESS (1.812s) [320.778434] [167/171] (709s left) i915_suspend (basic-s3-without-i915) [320.835315] Starting subtest: basic-s3-without-i915 [338.538852] Subtest basic-s3-without-i915: SUCCESS (1.650s) [344.996271] [168/171] (708s left) gem_exec_suspend (basic-s0) [345.065327] Starting subtest: basic-S0 [345.067171] Starting dynamic subtest: smem [362.499773] Dynamic subtest smem: SUCCESS (1.772s) [362.501708] Subtest basic-S0: SUCCESS (1.773s) [366.636587] [169/171] (706s left) gem_exec_suspend (basic-s3) [366.698710] Starting subtest: basic-S3 [366.700687] Starting dynamic subtest: smem [384.613121] Dynamic subtest smem: SUCCESS (1.925s) [384.615158] Subtest basic-S3: SUCCESS (1.926s) [388.803552] [170/171] (703s left) kms_chamelium_hpd (common-hpd-after-suspend) [388.928860] Subtest common-hpd-after-suspend: SKIP (0.000s) [388.977029] [171/171] (703s left) kms_pipe_crc_basic (suspend-read-crc) [389.083240] Starting subtest: suspend-read-crc [389.084983] Starting dynamic subtest: pipe-A-HDMI-A-1 [406.614870] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.649s) [406.622346] Starting dynamic subtest: pipe-B-HDMI-A-1 [424.568156] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.536s) [424.575811] Starting dynamic subtest: pipe-C-HDMI-A-1 [442.568905] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.530s) [442.570708] Subtest suspend-read-crc: SUCCESS (4.716s) [447.619897] Closing watchdogs Done.