[51.953197] Initializing watchdogs [51.953422] /dev/watchdog0 [51.964824] [001/171] (960s left) i915_module_load (load) [52.126955] Starting subtest: load [53.942047] Subtest load: SUCCESS (1.813s) [53.970122] [002/171] (958s left) core_auth (basic-auth) [54.299733] Starting subtest: basic-auth [54.305228] Subtest basic-auth: SUCCESS (0.012s) [54.401413] [003/171] (958s left) debugfs_test (read_all_entries) [54.754661] Starting subtest: read_all_entries [55.010272] Subtest read_all_entries: SUCCESS (0.248s) [55.182221] [004/171] (957s left) debugfs_test (basic-hwmon) [55.377276] Starting subtest: basic-hwmon [55.379448] Subtest basic-hwmon: SKIP (0.000s) [55.527788] [005/171] (957s left) fbdev (eof) [55.684910] Starting subtest: eof [55.687221] Subtest eof: SUCCESS (0.002s) [55.744215] [006/171] (956s left) fbdev (info) [55.885747] Starting subtest: info [55.886883] Subtest info: SUCCESS (0.000s) [55.961131] [007/171] (956s left) fbdev (nullptr) [56.117877] Starting subtest: nullptr [56.119158] Subtest nullptr: SUCCESS (0.001s) [56.177533] [008/171] (956s left) fbdev (read) [56.334529] Starting subtest: read [57.944193] Subtest read: SUCCESS (1.607s) [58.011779] [009/171] (954s left) fbdev (write) [58.170929] Starting subtest: write [58.984349] Subtest write: SUCCESS (0.815s) [59.047386] [010/171] (953s left) gem_basic (bad-close) [59.191925] Starting subtest: bad-close [59.194727] Subtest bad-close: SUCCESS (0.000s) [59.261745] [011/171] (953s left) gem_basic (create-close) [59.406722] Starting subtest: create-close [59.408977] Subtest create-close: SUCCESS (0.000s) [59.479891] [012/171] (953s left) gem_basic (create-fd-close) [59.634965] Starting subtest: create-fd-close [59.637169] Subtest create-fd-close: SUCCESS (0.001s) [59.712238] [013/171] (953s left) gem_busy (busy@all-engines) [59.878619] Starting subtest: busy [59.879878] Starting dynamic subtest: all-engines [59.957833] Dynamic subtest all-engines: SUCCESS (0.076s) [59.958983] Subtest busy: SUCCESS (0.077s) [60.296924] [014/171] (952s left) gem_close_race (basic-process) [60.466934] Starting subtest: basic-process [60.537396] Subtest basic-process: SUCCESS (0.071s) [60.729299] [015/171] (952s left) gem_close_race (basic-threads) [60.907926] Starting subtest: basic-threads [62.070445] Subtest basic-threads: SUCCESS (1.161s) [62.262415] [016/171] (950s left) gem_ctx_create (basic) [62.422291] Starting subtest: basic [62.423624] Subtest basic: SUCCESS (0.000s) [62.613147] [017/171] (950s left) gem_ctx_create (basic-files) [62.773940] Starting subtest: basic-files [64.805909] Subtest basic-files: SUCCESS (2.032s) [65.013225] [018/171] (947s left) gem_ctx_exec (basic) [65.162982] Starting subtest: basic [65.166368] Subtest basic: SUCCESS (0.005s) [65.264075] [019/171] (947s left) gem_exec_basic (basic) [65.422045] Starting subtest: basic [65.423820] Starting dynamic subtest: rcs0-smem [65.426082] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [65.439119] Starting dynamic subtest: bcs0-smem [65.440196] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [65.449564] Starting dynamic subtest: vcs0-smem [65.450701] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [65.459537] Starting dynamic subtest: vecs0-smem [65.460692] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [65.461824] Subtest basic: SUCCESS (0.008s) [65.632130] [020/171] (947s left) gem_exec_create (basic) [65.794949] Starting subtest: basic [65.797383] Starting dynamic subtest: smem [67.843343] Dynamic subtest smem: SUCCESS (2.048s) [67.844454] Subtest basic: SUCCESS (2.049s) [68.030959] [021/171] (944s left) gem_exec_fence (basic-busy) [68.321347] Starting subtest: basic-busy [68.323846] Starting dynamic subtest: rcs0 [68.344992] Dynamic subtest rcs0: SUCCESS (0.023s) [68.356413] Starting dynamic subtest: bcs0 [68.364057] Dynamic subtest bcs0: SUCCESS (0.019s) [68.376033] Starting dynamic subtest: vcs0 [68.383130] Dynamic subtest vcs0: SUCCESS (0.019s) [68.393656] Starting dynamic subtest: vecs0 [68.398214] Dynamic subtest vecs0: SUCCESS (0.015s) [68.399379] Subtest basic-busy: SUCCESS (0.078s) [69.050650] [022/171] (943s left) gem_exec_fence (basic-wait) [69.344470] Starting subtest: basic-wait [69.345622] Starting dynamic subtest: rcs0 [69.368842] Dynamic subtest rcs0: SUCCESS (0.026s) [69.379802] Starting dynamic subtest: bcs0 [69.398206] Dynamic subtest bcs0: SUCCESS (0.025s) [69.412118] Starting dynamic subtest: vcs0 [69.413297] Dynamic subtest vcs0: SUCCESS (0.015s) [69.423981] Starting dynamic subtest: vecs0 [69.425150] Dynamic subtest vecs0: SUCCESS (0.014s) [69.426305] Subtest basic-wait: SUCCESS (0.083s) [70.014560] [023/171] (943s left) gem_exec_fence (basic-await) [70.304937] Starting subtest: basic-await [70.306075] Starting dynamic subtest: rcs0 [70.407659] Dynamic subtest rcs0: SUCCESS (0.104s) [70.419462] Starting dynamic subtest: bcs0 [70.512564] Dynamic subtest bcs0: SUCCESS (0.105s) [70.524190] Starting dynamic subtest: vcs0 [70.623954] Dynamic subtest vcs0: SUCCESS (0.110s) [70.634834] Starting dynamic subtest: vecs0 [70.730801] Dynamic subtest vecs0: SUCCESS (0.105s) [70.731870] Subtest basic-await: SUCCESS (0.427s) [71.331546] [024/171] (941s left) gem_exec_fence (nb-await) [71.622977] Starting subtest: nb-await [71.625407] Starting dynamic subtest: rcs0 [71.691638] Dynamic subtest rcs0: SUCCESS (0.068s) [71.705749] Starting dynamic subtest: bcs0 [71.755971] Dynamic subtest bcs0: SUCCESS (0.064s) [71.769473] Starting dynamic subtest: vcs0 [71.822599] Dynamic subtest vcs0: SUCCESS (0.067s) [71.833236] Starting dynamic subtest: vecs0 [71.893571] Dynamic subtest vecs0: SUCCESS (0.068s) [71.894799] Subtest nb-await: SUCCESS (0.270s) [72.481729] [025/171] (940s left) gem_exec_gttfill (basic) [72.651092] Starting subtest: basic [82.961368] Subtest basic: SUCCESS (10.311s) [83.152340] [026/171] (929s left) gem_exec_parallel (engines) [83.413310] Starting subtest: engines [83.415589] Starting dynamic subtest: basic [86.384723] Dynamic subtest basic: SUCCESS (2.969s) [86.397690] Starting dynamic subtest: contexts [90.145987] Dynamic subtest contexts: SUCCESS (3.758s) [90.158066] Starting dynamic subtest: fds [94.475041] Dynamic subtest fds: SUCCESS (4.331s) [94.487632] Starting dynamic subtest: userptr [97.711466] Dynamic subtest userptr: SUCCESS (3.234s) [97.712972] Subtest engines: SUCCESS (14.298s) [97.915755] [027/171] (915s left) gem_exec_store (basic) [98.083641] Starting subtest: basic [98.134423] Subtest basic: SUCCESS (0.051s) [98.316275] [028/171] (914s left) gem_flink_basic (bad-flink) [98.467635] Starting subtest: bad-flink [98.469102] Subtest bad-flink: SUCCESS (0.000s) [98.549993] [029/171] (914s left) gem_flink_basic (bad-open) [98.696114] Starting subtest: bad-open [98.697350] Subtest bad-open: SUCCESS (0.000s) [98.764907] [030/171] (914s left) gem_flink_basic (basic) [98.909401] Starting subtest: basic [98.910624] Subtest basic: SUCCESS (0.000s) [98.998903] [031/171] (914s left) gem_flink_basic (double-flink) [99.144654] Starting subtest: double-flink [99.145893] Subtest double-flink: SUCCESS (0.000s) [99.233413] [032/171] (914s left) gem_flink_basic (flink-lifetime) [99.380057] Starting subtest: flink-lifetime [99.381232] Subtest flink-lifetime: SUCCESS (0.002s) [99.465263] [033/171] (913s left) gem_huc_copy (huc-copy) [99.619199] Starting subtest: huc-copy [99.621479] Subtest huc-copy: SKIP (0.000s) [99.716177] [034/171] (913s left) gem_linear_blits (basic) [100.020774] Starting subtest: basic [100.038532] Subtest basic: SUCCESS (0.015s) [100.177501] [035/171] (913s left) gem_mmap (basic) [100.425229] Starting subtest: basic [100.431550] Subtest basic: SUCCESS (0.002s) [100.517723] [036/171] (912s left) gem_mmap_gtt (basic) [100.663439] Starting subtest: basic [100.664896] Subtest basic: SUCCESS (0.001s) [100.752433] [037/171] (912s left) gem_render_linear_blits (basic) [100.897700] Starting subtest: basic [100.963968] Subtest basic: SUCCESS (0.062s) [101.018832] [038/171] (912s left) gem_render_tiled_blits (basic) [101.166184] Starting subtest: basic [101.247917] Subtest basic: SUCCESS (0.081s) [101.301288] [039/171] (912s left) gem_ringfill (basic-all) [101.661087] Starting subtest: basic-all [102.843667] Subtest basic-all: SUCCESS (1.179s) [102.951848] [040/171] (910s left) gem_softpin (allocator-basic) [103.101596] Starting subtest: allocator-basic [103.277794] Subtest allocator-basic: SUCCESS (0.175s) [103.384772] [041/171] (910s left) gem_softpin (allocator-basic-reserve) [103.534523] Starting subtest: allocator-basic-reserve [103.714744] Subtest allocator-basic-reserve: SUCCESS (0.178s) [103.815562] [042/171] (909s left) gem_softpin (safe-alignment) [103.970943] Starting subtest: safe-alignment [103.991458] Subtest safe-alignment: SUCCESS (0.020s) [104.083812] [043/171] (909s left) gem_sync (basic-all) [104.252698] Starting subtest: basic-all [106.421486] Subtest basic-all: SUCCESS (2.168s) [106.616771] [044/171] (907s left) gem_sync (basic-each) [106.779740] Starting subtest: basic-each [109.210624] Subtest basic-each: SUCCESS (2.431s) [109.399788] [045/171] (904s left) gem_tiled_blits (basic) [109.696526] Starting subtest: basic [109.731782] Subtest basic: SUCCESS (0.034s) [109.877895] [046/171] (903s left) gem_tiled_fence_blits (basic) [110.286143] Starting subtest: basic [110.315918] Subtest basic: SUCCESS (0.030s) [110.467715] [047/171] (903s left) gem_tiled_pread_basic [111.016424] [048/171] (902s left) gem_wait (busy@all-engines) [111.188734] Starting subtest: busy [111.190041] Starting dynamic subtest: all-engines [111.710628] Dynamic subtest all-engines: SUCCESS (0.521s) [111.712120] Subtest busy: SUCCESS (0.522s) [111.934342] [049/171] (901s left) gem_wait (wait@all-engines) [112.107065] Starting subtest: wait [112.108951] Starting dynamic subtest: all-engines [113.133363] Dynamic subtest all-engines: SUCCESS (1.029s) [113.134595] Subtest wait: SUCCESS (1.030s) [113.349972] [050/171] (900s left) i915_getparams_basic (basic-eu-total) [113.497337] Starting subtest: basic-eu-total [113.501057] Subtest basic-eu-total: SUCCESS (0.000s) [113.563825] [051/171] (900s left) i915_getparams_basic (basic-subslice-total) [113.709983] Starting subtest: basic-subslice-total [113.712466] Subtest basic-subslice-total: SUCCESS (0.000s) [113.782236] [052/171] (900s left) i915_hangman (error-state-basic) [113.944944] Starting subtest: error-state-basic [113.975441] Subtest error-state-basic: SUCCESS (0.024s) [114.066198] [053/171] (899s left) i915_pciid [114.283115] [054/171] (899s left) kms_addfb_basic (addfb25-bad-modifier) [114.436139] Starting subtest: addfb25-bad-modifier [114.438994] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [114.597650] [055/171] (899s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [114.747016] Starting subtest: addfb25-framebuffer-vs-set-tiling [114.748178] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.897825] [056/171] (899s left) kms_addfb_basic (addfb25-modifier-no-flag) [115.046098] Starting subtest: addfb25-modifier-no-flag [115.047155] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [115.197755] [057/171] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [115.347309] Starting subtest: addfb25-x-tiled-legacy [115.348453] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [115.497654] [058/171] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [115.647417] Starting subtest: addfb25-x-tiled-mismatch-legacy [115.648744] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [115.797726] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [116.012838] Starting subtest: addfb25-yf-tiled-legacy [116.014145] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [116.097658] [060/171] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [116.313356] Starting subtest: addfb25-y-tiled-legacy [116.314448] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [116.397659] [061/171] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [116.614669] Starting subtest: addfb25-y-tiled-small-legacy [116.616270] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [116.697516] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [116.844576] Starting subtest: bad-pitch-0 [116.845827] Subtest bad-pitch-0: SUCCESS (0.000s) [116.997643] [063/171] (897s left) kms_addfb_basic (bad-pitch-1024) [117.145274] Starting subtest: bad-pitch-1024 [117.146468] Subtest bad-pitch-1024: SUCCESS (0.000s) [117.297521] [064/171] (896s left) kms_addfb_basic (bad-pitch-128) [117.445965] Starting subtest: bad-pitch-128 [117.447305] Subtest bad-pitch-128: SUCCESS (0.000s) [117.614470] [065/171] (896s left) kms_addfb_basic (bad-pitch-256) [117.760690] Starting subtest: bad-pitch-256 [117.761995] Subtest bad-pitch-256: SUCCESS (0.000s) [117.915242] [066/171] (896s left) kms_addfb_basic (bad-pitch-32) [118.061558] Starting subtest: bad-pitch-32 [118.062812] Subtest bad-pitch-32: SUCCESS (0.000s) [118.214295] [067/171] (896s left) kms_addfb_basic (bad-pitch-63) [118.356641] Starting subtest: bad-pitch-63 [118.357836] Subtest bad-pitch-63: SUCCESS (0.000s) [118.515395] [068/171] (895s left) kms_addfb_basic (bad-pitch-65536) [118.659618] Starting subtest: bad-pitch-65536 [118.660783] Subtest bad-pitch-65536: SUCCESS (0.001s) [118.814239] [069/171] (895s left) kms_addfb_basic (bad-pitch-999) [118.962258] Starting subtest: bad-pitch-999 [118.963399] Subtest bad-pitch-999: SUCCESS (0.000s) [119.115402] [070/171] (895s left) kms_addfb_basic (basic) [119.261515] Starting subtest: basic [119.262764] Subtest basic: SUCCESS (0.000s) [119.414205] [071/171] (895s left) kms_addfb_basic (basic-x-tiled-legacy) [119.563571] Starting subtest: basic-x-tiled-legacy [119.564799] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [119.715394] [072/171] (894s left) kms_addfb_basic (basic-y-tiled-legacy) [119.863444] Starting subtest: basic-y-tiled-legacy [119.864884] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [120.016981] [073/171] (894s left) kms_addfb_basic (bo-too-small) [120.237731] Starting subtest: bo-too-small [120.239174] Subtest bo-too-small: SUCCESS (0.001s) [120.331147] [074/171] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [120.548695] Starting subtest: bo-too-small-due-to-tiling [120.549867] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [120.630938] [075/171] (893s left) kms_addfb_basic (clobberred-modifier) [120.775235] Starting subtest: clobberred-modifier [120.776400] Subtest clobberred-modifier: SUCCESS (0.001s) [120.930838] [076/171] (893s left) kms_addfb_basic (framebuffer-vs-set-tiling) [121.081727] Starting subtest: framebuffer-vs-set-tiling [121.082971] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s) [121.230919] [077/171] (893s left) kms_addfb_basic (invalid-get-prop) [121.373430] Starting subtest: invalid-get-prop [121.374903] Subtest invalid-get-prop: SUCCESS (0.000s) [121.515204] [078/171] (893s left) kms_addfb_basic (invalid-get-prop-any) [121.661173] Starting subtest: invalid-get-prop-any [121.662240] Subtest invalid-get-prop-any: SUCCESS (0.000s) [121.814088] [079/171] (892s left) kms_addfb_basic (invalid-set-prop) [121.962578] Starting subtest: invalid-set-prop [121.963885] Subtest invalid-set-prop: SUCCESS (0.000s) [122.113699] [080/171] (892s left) kms_addfb_basic (invalid-set-prop-any) [122.262625] Starting subtest: invalid-set-prop-any [122.263967] Subtest invalid-set-prop-any: SUCCESS (0.000s) [122.416187] [081/171] (892s left) kms_addfb_basic (no-handle) [122.568238] Starting subtest: no-handle [122.569386] Subtest no-handle: SUCCESS (0.000s) [122.713840] [082/171] (892s left) kms_addfb_basic (size-max) [122.918759] Starting subtest: size-max [122.919960] Subtest size-max: SUCCESS (0.000s) [122.997309] [083/171] (891s left) kms_addfb_basic (small-bo) [123.201544] Starting subtest: small-bo [123.202699] Subtest small-bo: SUCCESS (0.000s) [123.280870] [084/171] (891s left) kms_addfb_basic (tile-pitch-mismatch) [123.425042] Starting subtest: tile-pitch-mismatch [123.426184] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [123.564239] [085/171] (891s left) kms_addfb_basic (too-high) [123.771987] Starting subtest: too-high [123.773237] Subtest too-high: SUCCESS (0.001s) [123.847226] [086/171] (891s left) kms_addfb_basic (too-wide) [124.061868] Starting subtest: too-wide [124.062994] Subtest too-wide: SUCCESS (0.000s) [124.148100] [087/171] (890s left) kms_addfb_basic (unused-handle) [124.290370] Starting subtest: unused-handle [124.291541] Subtest unused-handle: SUCCESS (0.000s) [124.431855] [088/171] (890s left) kms_addfb_basic (unused-modifier) [124.577795] Starting subtest: unused-modifier [124.579104] Subtest unused-modifier: SUCCESS (0.000s) [124.730621] [089/171] (890s left) kms_addfb_basic (unused-offsets) [124.876904] Starting subtest: unused-offsets [124.878083] Subtest unused-offsets: SUCCESS (0.000s) [125.013940] [090/171] (889s left) kms_addfb_basic (unused-pitches) [125.155261] Starting subtest: unused-pitches [125.156343] Subtest unused-pitches: SUCCESS (0.000s) [125.297594] [091/171] (889s left) kms_busy (basic) [125.501935] Starting subtest: basic [125.507686] Starting dynamic subtest: flip [126.399210] Dynamic subtest flip: SUCCESS (0.895s) [126.419020] Starting dynamic subtest: modeset [127.820416] Dynamic subtest modeset: SUCCESS (1.420s) [127.821894] Subtest basic: SUCCESS (2.319s) [128.003269] [092/171] (887s left) kms_chamelium_hpd (dp-hpd-fast) [128.422604] Subtest dp-hpd-fast: SKIP (0.000s) [128.537353] [093/171] (886s left) kms_chamelium_edid (dp-edid-read) [129.005165] Subtest dp-edid-read: SKIP (0.000s) [129.234896] [094/171] (885s left) kms_chamelium_frames (dp-crc-fast) [129.671393] Subtest dp-crc-fast: SKIP (0.000s) [129.821557] [095/171] (885s left) kms_chamelium_hpd (hdmi-hpd-fast) [130.263502] Subtest hdmi-hpd-fast: SKIP (0.000s) [130.393655] [096/171] (884s left) kms_chamelium_edid (hdmi-edid-read) [130.833403] Subtest hdmi-edid-read: SKIP (0.000s) [130.993548] [097/171] (884s left) kms_chamelium_frames (hdmi-crc-fast) [131.449512] Subtest hdmi-crc-fast: SKIP (0.000s) [131.617212] [098/171] (883s left) kms_chamelium_hpd (vga-hpd-fast) [132.071820] Subtest vga-hpd-fast: SKIP (0.000s) [132.239586] [099/171] (882s left) kms_chamelium_edid (vga-edid-read) [132.695165] Subtest vga-edid-read: SKIP (0.000s) [132.848517] [100/171] (882s left) kms_prop_blob (basic) [132.994409] Starting subtest: basic [132.995759] Subtest basic: SUCCESS (0.000s) [133.075524] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [133.291685] Starting subtest: basic-busy-flip-before-cursor-atomic [133.293994] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [133.375711] [102/171] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [133.587465] Starting subtest: basic-busy-flip-before-cursor-legacy [133.589801] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.001s) [133.675872] [103/171] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [133.891767] Starting subtest: basic-flip-after-cursor-atomic [135.069108] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.178s) [135.264495] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [135.476685] Starting subtest: basic-flip-after-cursor-legacy [136.687506] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.211s) [136.893354] [105/171] (878s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [137.110730] Starting subtest: basic-flip-after-cursor-varying-size [138.351683] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.241s) [138.558504] [106/171] (876s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [138.772228] Starting subtest: basic-flip-before-cursor-atomic [139.949025] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.176s) [140.137326] [107/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [140.351220] Starting subtest: basic-flip-before-cursor-legacy [141.524950] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.173s) [141.713071] [108/171] (873s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [141.928117] Starting subtest: basic-flip-before-cursor-varying-size [143.149261] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.222s) [143.338283] [109/171] (872s left) kms_flip (basic-flip-vs-dpms) [143.529046] Starting subtest: basic-flip-vs-dpms [143.535023] Starting dynamic subtest: A-HDMI-A2 [144.935888] Dynamic subtest A-HDMI-A2: SUCCESS (1.401s) [144.963043] Starting dynamic subtest: B-HDMI-A2 [146.140985] Dynamic subtest B-HDMI-A2: SUCCESS (1.191s) [146.169902] Starting dynamic subtest: C-HDMI-A2 [147.331762] Dynamic subtest C-HDMI-A2: SUCCESS (1.186s) [147.337607] Subtest basic-flip-vs-dpms: SUCCESS (3.808s) [147.621886] [110/171] (867s left) kms_flip (basic-flip-vs-modeset) [147.819223] Starting subtest: basic-flip-vs-modeset [147.825788] Starting dynamic subtest: A-HDMI-A2 [149.358960] Dynamic subtest A-HDMI-A2: SUCCESS (1.527s) [149.382905] Starting dynamic subtest: B-HDMI-A2 [150.599879] Dynamic subtest B-HDMI-A2: SUCCESS (1.232s) [150.622909] Starting dynamic subtest: C-HDMI-A2 [151.847290] Dynamic subtest C-HDMI-A2: SUCCESS (1.244s) [151.848704] Subtest basic-flip-vs-modeset: SUCCESS (4.029s) [152.064423] [111/171] (863s left) kms_flip (basic-flip-vs-wf_vblank) [152.261468] Starting subtest: basic-flip-vs-wf_vblank [152.268478] Starting dynamic subtest: A-HDMI-A2 [153.814678] Dynamic subtest A-HDMI-A2: SUCCESS (1.540s) [153.839923] Starting dynamic subtest: B-HDMI-A2 [155.244992] Dynamic subtest B-HDMI-A2: SUCCESS (1.418s) [155.271045] Starting dynamic subtest: C-HDMI-A2 [156.662796] Dynamic subtest C-HDMI-A2: SUCCESS (1.418s) [156.667321] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.402s) [157.093837] [112/171] (858s left) kms_flip (basic-plain-flip) [157.296789] Starting subtest: basic-plain-flip [157.303327] Starting dynamic subtest: A-HDMI-A2 [158.545743] Dynamic subtest A-HDMI-A2: SUCCESS (1.237s) [158.571910] Starting dynamic subtest: B-HDMI-A2 [159.725414] Dynamic subtest B-HDMI-A2: SUCCESS (1.169s) [159.753910] Starting dynamic subtest: C-HDMI-A2 [160.873662] Dynamic subtest C-HDMI-A2: SUCCESS (1.137s) [160.875480] Subtest basic-plain-flip: SUCCESS (3.578s) [161.316573] [113/171] (854s left) kms_force_connector_basic (force-connector-state) [161.585215] Starting subtest: force-connector-state [163.253246] Subtest force-connector-state: SUCCESS (1.668s) [163.867495] [114/171] (851s left) kms_force_connector_basic (force-edid) [164.130270] Starting subtest: force-edid [164.198082] Subtest force-edid: SUCCESS (0.067s) [164.550720] [115/171] (851s left) kms_force_connector_basic (force-load-detect) [164.817668] Starting subtest: force-load-detect [164.820914] Subtest force-load-detect: SKIP (0.000s) [165.100794] [116/171] (850s left) kms_force_connector_basic (prune-stale-modes) [165.352559] Starting subtest: prune-stale-modes [165.395460] Subtest prune-stale-modes: SUCCESS (0.045s) [165.750775] [117/171] (849s left) kms_frontbuffer_tracking (basic) [165.997158] Starting subtest: basic [168.836766] Subtest basic: SUCCESS (2.840s) [168.951219] [118/171] (846s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [169.187924] Starting subtest: compare-crc-sanitycheck-xr24 [169.193655] Starting dynamic subtest: pipe-A-HDMI-A-2 [169.799737] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.606s) [169.831945] Starting dynamic subtest: pipe-B-HDMI-A-2 [170.670761] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.851s) [170.702466] Starting dynamic subtest: pipe-C-HDMI-A-2 [171.626365] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.945s) [171.630861] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.440s) [171.847830] [119/171] (843s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [172.072973] Starting subtest: compare-crc-sanitycheck-nv12 [172.078213] Starting dynamic subtest: pipe-A-HDMI-A-2 [172.754979] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.677s) [172.786938] Starting dynamic subtest: pipe-B-HDMI-A-2 [173.843311] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.071s) [173.872921] Starting dynamic subtest: pipe-C-HDMI-A-2 [175.211890] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.350s) [175.213074] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.139s) [175.453965] [120/171] (840s left) kms_pipe_crc_basic (hang-read-crc) [175.672854] Starting subtest: hang-read-crc [175.674167] Starting dynamic subtest: pipe-A-HDMI-A-2 [177.184766] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.513s) [177.213743] Starting dynamic subtest: pipe-B-HDMI-A-2 [179.435955] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.237s) [179.464289] Starting dynamic subtest: pipe-C-HDMI-A-2 [181.928272] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.475s) [181.929385] Subtest hang-read-crc: SUCCESS (6.259s) [182.150786] [121/171] (833s left) kms_pipe_crc_basic (nonblocking-crc) [182.383501] Starting subtest: nonblocking-crc [182.390974] Starting dynamic subtest: pipe-A-HDMI-A-2 [183.172198] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.782s) [183.200918] Starting dynamic subtest: pipe-B-HDMI-A-2 [184.241259] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.060s) [184.269616] Starting dynamic subtest: pipe-C-HDMI-A-2 [185.917467] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.662s) [185.920457] Subtest nonblocking-crc: SUCCESS (3.536s) [186.145071] [122/171] (829s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [186.382183] Starting subtest: nonblocking-crc-frame-sequence [186.387816] Starting dynamic subtest: pipe-A-HDMI-A-2 [187.167102] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.779s) [187.194977] Starting dynamic subtest: pipe-B-HDMI-A-2 [188.504351] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.322s) [188.531971] Starting dynamic subtest: pipe-C-HDMI-A-2 [189.683226] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.161s) [189.684341] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.300s) [189.913913] [123/171] (826s left) kms_pipe_crc_basic (read-crc) [190.151063] Starting subtest: read-crc [190.156569] Starting dynamic subtest: pipe-A-HDMI-A-2 [190.873800] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.717s) [190.903054] Starting dynamic subtest: pipe-B-HDMI-A-2 [191.872210] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.984s) [191.900913] Starting dynamic subtest: pipe-C-HDMI-A-2 [193.412411] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.523s) [193.413540] Subtest read-crc: SUCCESS (3.262s) [193.635633] [124/171] (822s left) kms_pipe_crc_basic (read-crc-frame-sequence) [193.866399] Starting subtest: read-crc-frame-sequence [193.871588] Starting dynamic subtest: pipe-A-HDMI-A-2 [194.553793] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.681s) [194.581924] Starting dynamic subtest: pipe-B-HDMI-A-2 [195.634166] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.067s) [195.663283] Starting dynamic subtest: pipe-C-HDMI-A-2 [197.011845] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.369s) [197.015977] Subtest read-crc-frame-sequence: SUCCESS (3.148s) [197.243114] [125/171] (818s left) kms_psr (primary_page_flip) [197.396783] Subtest primary_page_flip: SKIP (0.000s) [197.445755] [126/171] (818s left) kms_psr (cursor_plane_move) [197.594861] Subtest cursor_plane_move: SKIP (0.000s) [197.645096] [127/171] (818s left) kms_psr (sprite_plane_onoff) [197.792253] Subtest sprite_plane_onoff: SKIP (0.000s) [197.845030] [128/171] (818s left) kms_psr (primary_mmap_gtt) [197.991887] Subtest primary_mmap_gtt: SKIP (0.000s) [198.046916] [129/171] (818s left) kms_setmode (basic-clone-single-crtc) [198.197391] Starting subtest: basic-clone-single-crtc [198.200910] Subtest basic-clone-single-crtc: SKIP (0.001s) [198.292074] [130/171] (817s left) i915_pm_backlight (basic-brightness) [198.526418] Subtest basic-brightness: SKIP (0.000s) [198.580191] [131/171] (817s left) i915_pm_rpm (basic-pci-d3-state) [200.479261] Starting subtest: basic-pci-d3-state [201.528258] Subtest basic-pci-d3-state: SUCCESS (1.049s) [201.721912] [132/171] (814s left) i915_pm_rpm (basic-rte) [201.864758] Starting subtest: basic-rte [203.948570] Subtest basic-rte: SUCCESS (2.080s) [204.725784] [133/171] (811s left) i915_pm_rps (basic-api) [204.888050] Starting subtest: basic-api [204.898802] Subtest basic-api: SUCCESS (0.010s) [204.990696] [134/171] (811s left) prime_self_import (basic-llseek-bad) [205.133908] Starting subtest: basic-llseek-bad [205.144185] Subtest basic-llseek-bad: SUCCESS (0.010s) [205.223611] [135/171] (811s left) prime_self_import (basic-llseek-size) [205.364910] Starting subtest: basic-llseek-size [205.369277] Subtest basic-llseek-size: SUCCESS (0.005s) [205.457299] [136/171] (810s left) prime_self_import (basic-with_fd_dup) [205.598727] Starting subtest: basic-with_fd_dup [205.612459] Subtest basic-with_fd_dup: SUCCESS (0.014s) [205.690550] [137/171] (810s left) prime_self_import (basic-with_one_bo) [205.833829] Starting subtest: basic-with_one_bo [205.844539] Subtest basic-with_one_bo: SUCCESS (0.010s) [205.910586] [138/171] (810s left) prime_self_import (basic-with_one_bo_two_files) [206.049161] Starting subtest: basic-with_one_bo_two_files [206.058323] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s) [206.140611] [139/171] (810s left) prime_self_import (basic-with_two_bos) [206.283757] Starting subtest: basic-with_two_bos [206.295964] Subtest basic-with_two_bos: SUCCESS (0.012s) [206.373787] [140/171] (810s left) prime_vgem (basic-fence-flip) [206.542305] Starting subtest: basic-fence-flip [207.085560] Subtest basic-fence-flip: SUCCESS (0.543s) [207.192661] [141/171] (809s left) prime_vgem (basic-fence-mmap) [207.362910] Starting subtest: basic-fence-mmap [207.418996] Subtest basic-fence-mmap: SUCCESS (0.054s) [207.508332] [142/171] (808s left) prime_vgem (basic-fence-read) [207.677397] Starting subtest: basic-fence-read [207.777809] Subtest basic-fence-read: SUCCESS (0.097s) [207.858109] [143/171] (808s left) prime_vgem (basic-gtt) [208.026830] Starting subtest: basic-gtt [208.055427] Subtest basic-gtt: SUCCESS (0.028s) [208.140737] [144/171] (808s left) prime_vgem (basic-read) [208.308479] Starting subtest: basic-read [208.356730] Subtest basic-read: SUCCESS (0.045s) [208.440669] [145/171] (808s left) prime_vgem (basic-write) [208.610397] Starting subtest: basic-write [208.664563] Subtest basic-write: SUCCESS (0.054s) [208.757486] [146/171] (807s left) vgem_basic (setversion) [208.909762] Starting subtest: setversion [208.912259] Subtest setversion: SUCCESS (0.000s) [208.973956] [147/171] (807s left) vgem_basic (create) [209.126279] Starting subtest: create [209.129255] Subtest create: SUCCESS (0.002s) [209.190658] [148/171] (807s left) vgem_basic (debugfs) [209.343139] Starting subtest: debugfs [209.346113] Subtest debugfs: SUCCESS (0.002s) [209.407359] [149/171] (807s left) vgem_basic (dmabuf-export) [209.560259] Starting subtest: dmabuf-export [209.567762] Subtest dmabuf-export: SUCCESS (0.008s) [209.657366] [150/171] (807s left) vgem_basic (dmabuf-fence) [209.809985] Starting subtest: dmabuf-fence [209.813526] Subtest dmabuf-fence: SUCCESS (0.003s) [209.874022] [151/171] (806s left) vgem_basic (dmabuf-fence-before) [210.026522] Starting subtest: dmabuf-fence-before [210.029611] Subtest dmabuf-fence-before: SUCCESS (0.002s) [210.090685] [152/171] (806s left) vgem_basic (dmabuf-mmap) [210.243371] Starting subtest: dmabuf-mmap [210.275093] Subtest dmabuf-mmap: SUCCESS (0.031s) [210.340558] [153/171] (806s left) vgem_basic (mmap) [210.493447] Starting subtest: mmap [210.514364] Subtest mmap: SUCCESS (0.021s) [210.573992] [154/171] (806s left) vgem_basic (second-client) [210.726723] Starting subtest: second-client [210.759149] Subtest second-client: SUCCESS (0.032s) [210.826061] [155/171] (806s left) vgem_basic (sysfs) [210.976303] Starting subtest: sysfs [210.979423] Subtest sysfs: SUCCESS (0.003s) [211.040937] [156/171] (805s left) core_hotunplug (unbind-rebind) [211.259299] Starting subtest: unbind-rebind [212.910962] Subtest unbind-rebind: SUCCESS (1.648s) [212.977857] [157/171] (803s left) vgem_basic (unload) [213.251859] Starting subtest: unload [242.286919] Subtest unload: SUCCESS (29.031s) [242.409716] [158/171] (774s left) i915_module_load (reload) [242.555914] Starting subtest: reload [245.355951] Subtest reload: SUCCESS (2.800s) [245.439207] [159/171] (771s left) gem_lmem_swapping (basic) [245.713324] Subtest basic: SKIP (0.000s) [245.799736] [160/171] (771s left) gem_lmem_swapping (parallel-random-engines) [246.025438] Subtest parallel-random-engines: SKIP (0.000s) [246.071921] [161/171] (771s left) gem_lmem_swapping (random-engines) [246.224740] Subtest random-engines: SKIP (0.000s) [246.271804] [162/171] (770s left) gem_lmem_swapping (verify-random) [246.422786] Subtest verify-random: SKIP (0.000s) [246.471912] [163/171] (770s left) i915_pm_rpm (module-reload) [248.446418] Starting subtest: module-reload [257.683034] Subtest module-reload: SUCCESS (9.236s) [257.711859] [164/171] (759s left) i915_selftest (live) [257.876696] Starting subtest: live [257.879777] Starting dynamic subtest: sanitycheck [258.882564] Dynamic subtest sanitycheck: SUCCESS (1.002s) [258.900150] Starting dynamic subtest: uncore [259.782560] Dynamic subtest uncore: SUCCESS (0.888s) [259.799968] Starting dynamic subtest: workarounds [260.873847] Dynamic subtest workarounds: SUCCESS (1.088s) [260.887896] Starting dynamic subtest: gt_engines [262.239025] Dynamic subtest gt_engines: SUCCESS (1.354s) [262.252835] Starting dynamic subtest: gt_timelines [275.614157] Dynamic subtest gt_timelines: SUCCESS (13.373s) [275.627981] Starting dynamic subtest: gt_contexts [276.548459] Dynamic subtest gt_contexts: SUCCESS (0.933s) [276.565103] Starting dynamic subtest: gt_lrc [280.164081] Dynamic subtest gt_lrc: SUCCESS (3.613s) [280.178163] Starting dynamic subtest: gt_mocs [281.222828] Dynamic subtest gt_mocs: SUCCESS (1.056s) [281.236300] Starting dynamic subtest: gt_pm [289.189077] Dynamic subtest gt_pm: SUCCESS (7.963s) [289.200364] Starting dynamic subtest: gt_heartbeat [290.192747] Dynamic subtest gt_heartbeat: SUCCESS (1.002s) [290.208114] Starting dynamic subtest: gt_tlb [291.901038] Dynamic subtest gt_tlb: SUCCESS (1.705s) [291.914152] Starting dynamic subtest: requests [299.189275] Dynamic subtest requests: SUCCESS (7.286s) [299.199601] Starting dynamic subtest: migrate [302.990064] Dynamic subtest migrate: SUCCESS (3.797s) [303.002490] Starting dynamic subtest: active [303.930327] Dynamic subtest active: SUCCESS (0.939s) [303.946940] Starting dynamic subtest: objects [306.923059] Dynamic subtest objects: SUCCESS (2.980s) [306.936371] Starting dynamic subtest: mman [313.547133] Dynamic subtest mman: SUCCESS (6.622s) [313.560384] Starting dynamic subtest: dmabuf [314.439690] Dynamic subtest dmabuf: SUCCESS (0.891s) [314.456744] Starting dynamic subtest: vma [315.338482] Dynamic subtest vma: SUCCESS (0.897s) [315.355343] Starting dynamic subtest: coherency [321.806141] Dynamic subtest coherency: SUCCESS (6.464s) [321.819357] Starting dynamic subtest: gtt [330.311259] Dynamic subtest gtt: SUCCESS (8.503s) [330.324810] Starting dynamic subtest: gem [331.389581] Dynamic subtest gem: SUCCESS (1.077s) [331.402778] Starting dynamic subtest: evict [334.668965] Dynamic subtest evict: SUCCESS (3.276s) [334.682032] Starting dynamic subtest: hugepages [342.254194] Dynamic subtest hugepages: SUCCESS (7.582s) [342.268153] Starting dynamic subtest: gem_contexts [359.330097] Dynamic subtest gem_contexts: SUCCESS (17.072s) [359.341767] Starting dynamic subtest: client [360.164999] Dynamic subtest client: SUCCESS (0.835s) [360.187968] Starting dynamic subtest: gem_migrate [361.257667] Dynamic subtest gem_migrate: SUCCESS (1.090s) [361.270904] Starting dynamic subtest: reset [366.471173] Dynamic subtest reset: SUCCESS (5.211s) [366.485677] Starting dynamic subtest: memory_region [367.359575] Dynamic subtest memory_region: SUCCESS (0.886s) [367.376983] Starting dynamic subtest: hangcheck [391.307040] Dynamic subtest hangcheck: SUCCESS (23.944s) [391.320191] Starting dynamic subtest: execlists [401.421071] Dynamic subtest execlists: SUCCESS (10.112s) [401.434558] Starting dynamic subtest: ring_submission [402.229393] Dynamic subtest ring_submission: SUCCESS (0.808s) [402.246336] Starting dynamic subtest: perf [403.246772] Dynamic subtest perf: SUCCESS (1.016s) [403.261164] Starting dynamic subtest: slpc [404.167464] Dynamic subtest slpc: SUCCESS (0.919s) [404.184144] Starting dynamic subtest: guc [405.113708] Dynamic subtest guc: SUCCESS (0.944s) [405.126415] Starting dynamic subtest: guc_multi_lrc [405.975649] Dynamic subtest guc_multi_lrc: SUCCESS (0.858s) [405.994056] Starting dynamic subtest: guc_hang [406.869303] Dynamic subtest guc_hang: SUCCESS (0.892s) [406.888850] Starting dynamic subtest: late_gt_pm [407.887367] Dynamic subtest late_gt_pm: SUCCESS (1.012s) [407.888450] Subtest live: SUCCESS (150.011s) [408.062765] [165/171] (609s left) dmabuf (all-tests) [408.215961] Starting subtest: all-tests [408.223801] Starting dynamic subtest: sanitycheck [408.281833] Dynamic subtest sanitycheck: SUCCESS (0.062s) [408.296339] Starting dynamic subtest: dma_fence [408.476839] Dynamic subtest dma_fence: SUCCESS (0.190s) [408.498892] Starting dynamic subtest: dma_fence_chain [426.325117] Dynamic subtest dma_fence_chain: SUCCESS (17.845s) [426.345176] Starting dynamic subtest: dma_fence_unwrap [426.386714] Dynamic subtest dma_fence_unwrap: SUCCESS (0.059s) [426.407195] Starting dynamic subtest: dma_resv [426.446839] Dynamic subtest dma_resv: SUCCESS (0.057s) [426.453715] Subtest all-tests: SUCCESS (18.233s) [426.478972] [166/171] (590s left) i915_suspend (basic-s2idle-without-i915) [426.621044] Starting subtest: basic-s2idle-without-i915 [445.548766] Subtest basic-s2idle-without-i915: SUCCESS (4.166s) [450.796641] [167/171] (586s left) i915_suspend (basic-s3-without-i915) [450.942874] Starting subtest: basic-s3-without-i915 [472.095535] Subtest basic-s3-without-i915: SUCCESS (4.730s) [474.460755] [168/171] (581s left) gem_exec_suspend (basic-s0) [474.634983] Starting subtest: basic-S0 [474.641086] Starting dynamic subtest: smem [494.419216] Dynamic subtest smem: SUCCESS (4.767s) [494.421178] Subtest basic-S0: SUCCESS (4.770s) [496.224564] [169/171] (576s left) gem_exec_suspend (basic-s3) [496.388675] Starting subtest: basic-S3 [496.391928] Starting dynamic subtest: smem [518.732167] Dynamic subtest smem: SUCCESS (6.141s) [518.734140] Subtest basic-S3: SUCCESS (6.144s) [519.909081] [170/171] (569s left) kms_chamelium_hpd (common-hpd-after-suspend) [520.385244] Subtest common-hpd-after-suspend: SKIP (0.000s) [520.565336] [171/171] (568s left) kms_pipe_crc_basic (suspend-read-crc) [520.796757] Starting subtest: suspend-read-crc [520.801098] Starting dynamic subtest: pipe-A-HDMI-A-2 [541.212390] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.335s) [541.245273] Starting dynamic subtest: pipe-B-HDMI-A-2 [563.121910] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.376s) [563.153033] Starting dynamic subtest: pipe-C-HDMI-A-2 [585.805501] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.216s) [585.807279] Subtest suspend-read-crc: SUCCESS (15.962s) [586.922135] Closing watchdogs Done.