[42.838042] Initializing watchdogs [42.838211] /dev/watchdog0 [42.848651] [001/171] (960s left) i915_module_load (load) [42.995982] Starting subtest: load [45.713136] Subtest load: SUCCESS (2.717s) [45.740025] [002/171] (957s left) core_auth (basic-auth) [45.881648] Starting subtest: basic-auth [45.882728] Subtest basic-auth: SUCCESS (0.002s) [45.961465] [003/171] (957s left) debugfs_test (read_all_entries) [46.117439] Starting subtest: read_all_entries [46.197542] Subtest read_all_entries: SUCCESS (0.080s) [46.312037] [004/171] (957s left) debugfs_test (basic-hwmon) [46.455398] Starting subtest: basic-hwmon [46.469128] Subtest basic-hwmon: SKIP (0.000s) [46.572835] [005/171] (956s left) fbdev (eof) [46.747346] Starting subtest: eof [46.748505] Subtest eof: SUCCESS (0.001s) [46.813115] [006/171] (956s left) fbdev (info) [46.978444] Starting subtest: info [46.979609] Subtest info: SUCCESS (0.000s) [47.068703] [007/171] (956s left) fbdev (nullptr) [47.214568] Starting subtest: nullptr [47.215612] Subtest nullptr: SUCCESS (0.000s) [47.282040] [008/171] (956s left) fbdev (read) [47.431108] Starting subtest: read [54.520527] Subtest read: SUCCESS (7.055s) [54.563599] [009/171] (949s left) fbdev (write) [54.715408] Starting subtest: write [58.489867] Subtest write: SUCCESS (3.740s) [58.529965] [010/171] (945s left) gem_basic (bad-close) [58.665274] Starting subtest: bad-close [58.667400] Subtest bad-close: SUCCESS (0.000s) [58.745786] [011/171] (944s left) gem_basic (create-close) [58.884525] Starting subtest: create-close [58.886573] Subtest create-close: SUCCESS (0.000s) [58.979037] [012/171] (944s left) gem_basic (create-fd-close) [59.117691] Starting subtest: create-fd-close [59.120453] Subtest create-fd-close: SUCCESS (0.000s) [59.213084] [013/171] (944s left) gem_busy (busy@all-engines) [59.372478] Starting subtest: busy [59.373636] Starting dynamic subtest: all-engines [59.439833] Dynamic subtest all-engines: SUCCESS (0.067s) [59.440955] Subtest busy: SUCCESS (0.067s) [59.831125] [014/171] (943s left) gem_close_race (basic-process) [59.992672] Starting subtest: basic-process [60.065852] Subtest basic-process: SUCCESS (0.072s) [60.264589] [015/171] (943s left) gem_close_race (basic-threads) [60.424896] Starting subtest: basic-threads [61.586703] Subtest basic-threads: SUCCESS (1.162s) [61.799908] [016/171] (941s left) gem_ctx_create (basic) [61.951932] Starting subtest: basic [61.953180] Subtest basic: SUCCESS (0.000s) [62.148593] [017/171] (941s left) gem_ctx_create (basic-files) [62.302526] Starting subtest: basic-files [64.328319] Subtest basic-files: SUCCESS (2.026s) [64.546047] [018/171] (939s left) gem_ctx_exec (basic) [64.690474] Starting subtest: basic [64.695696] Subtest basic: SUCCESS (0.005s) [64.796461] [019/171] (939s left) gem_exec_basic (basic) [64.947252] Starting subtest: basic [64.948595] Starting dynamic subtest: rcs0-smem [64.949806] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [64.961635] Starting dynamic subtest: bcs0-smem [64.962947] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [64.973453] Starting dynamic subtest: vcs0-smem [64.974727] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [64.985208] Starting dynamic subtest: vecs0-smem [64.986503] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [64.987718] Subtest basic: SUCCESS (0.006s) [65.147893] [020/171] (938s left) gem_exec_create (basic) [65.302812] Starting subtest: basic [65.304025] Starting dynamic subtest: smem [67.343349] Dynamic subtest smem: SUCCESS (2.040s) [67.344346] Subtest basic: SUCCESS (2.040s) [67.566639] [021/171] (936s left) gem_exec_fence (basic-busy) [67.873412] Starting subtest: basic-busy [67.874561] Starting dynamic subtest: rcs0 [67.890616] Dynamic subtest rcs0: SUCCESS (0.026s) [67.902295] Starting dynamic subtest: bcs0 [67.924299] Dynamic subtest bcs0: SUCCESS (0.033s) [67.937438] Starting dynamic subtest: vcs0 [67.957894] Dynamic subtest vcs0: SUCCESS (0.033s) [67.973205] Starting dynamic subtest: vecs0 [67.984391] Dynamic subtest vecs0: SUCCESS (0.027s) [67.985582] Subtest basic-busy: SUCCESS (0.120s) [68.583248] [022/171] (935s left) gem_exec_fence (basic-wait) [68.886294] Starting subtest: basic-wait [68.887565] Starting dynamic subtest: rcs0 [68.911305] Dynamic subtest rcs0: SUCCESS (0.033s) [68.926548] Starting dynamic subtest: bcs0 [68.941397] Dynamic subtest bcs0: SUCCESS (0.030s) [68.953855] Starting dynamic subtest: vcs0 [68.963389] Dynamic subtest vcs0: SUCCESS (0.022s) [68.975276] Starting dynamic subtest: vecs0 [68.981337] Dynamic subtest vecs0: SUCCESS (0.018s) [68.982415] Subtest basic-wait: SUCCESS (0.104s) [69.533584] [023/171] (934s left) gem_exec_fence (basic-await) [69.835916] Starting subtest: basic-await [69.837158] Starting dynamic subtest: rcs0 [69.928901] Dynamic subtest rcs0: SUCCESS (0.099s) [69.954643] Starting dynamic subtest: bcs0 [70.042675] Dynamic subtest bcs0: SUCCESS (0.113s) [70.070258] Starting dynamic subtest: vcs0 [70.169697] Dynamic subtest vcs0: SUCCESS (0.125s) [70.197461] Starting dynamic subtest: vecs0 [70.306980] Dynamic subtest vecs0: SUCCESS (0.129s) [70.308971] Subtest basic-await: SUCCESS (0.471s) [70.884216] [024/171] (933s left) gem_exec_fence (nb-await) [71.187859] Starting subtest: nb-await [71.189056] Starting dynamic subtest: rcs0 [71.246285] Dynamic subtest rcs0: SUCCESS (0.065s) [71.264682] Starting dynamic subtest: bcs0 [71.315591] Dynamic subtest bcs0: SUCCESS (0.068s) [71.342859] Starting dynamic subtest: vcs0 [71.391315] Dynamic subtest vcs0: SUCCESS (0.076s) [71.419331] Starting dynamic subtest: vecs0 [71.466237] Dynamic subtest vecs0: SUCCESS (0.074s) [71.468249] Subtest nb-await: SUCCESS (0.286s) [72.033638] [025/171] (931s left) gem_exec_gttfill (basic) [72.190189] Starting subtest: basic [78.008261] Subtest basic: SUCCESS (5.810s) [78.204530] [026/171] (925s left) gem_exec_parallel (engines) [78.422527] Starting subtest: engines [78.423709] Starting dynamic subtest: basic [80.977022] Dynamic subtest basic: SUCCESS (2.526s) [80.990446] Starting dynamic subtest: contexts [84.088997] Dynamic subtest contexts: SUCCESS (3.131s) [84.102779] Starting dynamic subtest: fds [88.897413] Dynamic subtest fds: SUCCESS (4.811s) [88.911043] Starting dynamic subtest: userptr [91.502860] Dynamic subtest userptr: SUCCESS (2.586s) [91.504560] Subtest engines: SUCCESS (13.054s) [91.728432] [027/171] (912s left) gem_exec_store (basic) [91.897441] Starting subtest: basic [91.958170] Subtest basic: SUCCESS (0.060s) [92.166691] [028/171] (911s left) gem_flink_basic (bad-flink) [92.302837] Starting subtest: bad-flink [92.304048] Subtest bad-flink: SUCCESS (0.000s) [92.382657] [029/171] (911s left) gem_flink_basic (bad-open) [92.520191] Starting subtest: bad-open [92.521397] Subtest bad-open: SUCCESS (0.000s) [92.599439] [030/171] (911s left) gem_flink_basic (basic) [92.735555] Starting subtest: basic [92.736708] Subtest basic: SUCCESS (0.000s) [92.849110] [031/171] (911s left) gem_flink_basic (double-flink) [92.986377] Starting subtest: double-flink [92.987508] Subtest double-flink: SUCCESS (0.000s) [93.099677] [032/171] (911s left) gem_flink_basic (flink-lifetime) [93.236466] Starting subtest: flink-lifetime [93.239286] Subtest flink-lifetime: SUCCESS (0.002s) [93.349296] [033/171] (910s left) gem_huc_copy (huc-copy) [93.491419] Starting subtest: huc-copy [93.493539] Subtest huc-copy: SKIP (0.000s) [93.615840] [034/171] (910s left) gem_linear_blits (basic) [93.900435] Starting subtest: basic [93.913441] Subtest basic: SUCCESS (0.013s) [94.050155] [035/171] (910s left) gem_mmap (basic) [94.246217] Starting subtest: basic [94.251149] Subtest basic: SUCCESS (0.001s) [94.349423] [036/171] (909s left) gem_mmap_gtt (basic) [94.487374] Starting subtest: basic [94.488501] Subtest basic: SUCCESS (0.001s) [94.564827] [037/171] (909s left) gem_render_linear_blits (basic) [94.704899] Starting subtest: basic [94.755301] Subtest basic: SUCCESS (0.050s) [94.831250] [038/171] (909s left) gem_render_tiled_blits (basic) [94.976328] Starting subtest: basic [95.036817] Subtest basic: SUCCESS (0.060s) [95.099571] [039/171] (909s left) gem_ringfill (basic-all) [95.390262] Starting subtest: basic-all [96.609601] Subtest basic-all: SUCCESS (1.210s) [96.684096] [040/171] (907s left) gem_softpin (allocator-basic) [96.828306] Starting subtest: allocator-basic [97.001062] Subtest allocator-basic: SUCCESS (0.164s) [97.099355] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [97.254181] Starting subtest: allocator-basic-reserve [97.425976] Subtest allocator-basic-reserve: SUCCESS (0.163s) [97.535226] [042/171] (906s left) gem_softpin (safe-alignment) [97.689853] Starting subtest: safe-alignment [97.708459] Subtest safe-alignment: SUCCESS (0.018s) [97.817389] [043/171] (906s left) gem_sync (basic-all) [97.974407] Starting subtest: basic-all [100.229967] Subtest basic-all: SUCCESS (2.233s) [100.418156] [044/171] (904s left) gem_sync (basic-each) [100.575992] Starting subtest: basic-each [102.837831] Subtest basic-each: SUCCESS (2.264s) [103.055846] [045/171] (901s left) gem_tiled_blits (basic) [103.336432] Starting subtest: basic [103.365799] Subtest basic: SUCCESS (0.030s) [103.501384] [046/171] (901s left) gem_tiled_fence_blits (basic) [103.842087] Starting subtest: basic [103.869414] Subtest basic: SUCCESS (0.027s) [103.996668] [047/171] (900s left) gem_tiled_pread_basic [104.534474] [048/171] (900s left) gem_wait (busy@all-engines) [104.704471] Starting subtest: busy [104.705651] Starting dynamic subtest: all-engines [105.242651] Dynamic subtest all-engines: SUCCESS (0.538s) [105.243801] Subtest busy: SUCCESS (0.538s) [105.485400] [049/171] (899s left) gem_wait (wait@all-engines) [105.648905] Starting subtest: wait [105.650128] Starting dynamic subtest: all-engines [106.688318] Dynamic subtest all-engines: SUCCESS (1.038s) [106.690317] Subtest wait: SUCCESS (1.039s) [106.934878] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [107.066678] Starting subtest: basic-eu-total [107.069017] Subtest basic-eu-total: SUCCESS (0.000s) [107.149740] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [107.288978] Starting subtest: basic-subslice-total [107.291561] Subtest basic-subslice-total: SUCCESS (0.000s) [107.366472] [052/171] (897s left) i915_hangman (error-state-basic) [107.520514] Starting subtest: error-state-basic [107.531545] Subtest error-state-basic: SUCCESS (0.011s) [107.617843] [053/171] (897s left) i915_pciid [107.833618] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [107.975773] Starting subtest: addfb25-bad-modifier [107.976884] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [108.116199] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [108.256728] Starting subtest: addfb25-framebuffer-vs-set-tiling [108.257972] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [108.383971] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [108.524420] Starting subtest: addfb25-modifier-no-flag [108.525516] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [108.649710] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [108.789349] Starting subtest: addfb25-x-tiled-legacy [108.790503] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [108.916472] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [109.054789] Starting subtest: addfb25-x-tiled-mismatch-legacy [109.056092] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [109.183122] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [109.351188] Starting subtest: addfb25-yf-tiled-legacy [109.352231] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [109.468870] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [109.637325] Starting subtest: addfb25-y-tiled-legacy [109.638443] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [109.733087] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [109.901459] Starting subtest: addfb25-y-tiled-small-legacy [109.902768] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [109.999140] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [110.139178] Starting subtest: bad-pitch-0 [110.140272] Subtest bad-pitch-0: SUCCESS (0.000s) [110.266541] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [110.405608] Starting subtest: bad-pitch-1024 [110.406791] Subtest bad-pitch-1024: SUCCESS (0.000s) [110.533283] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [110.671831] Starting subtest: bad-pitch-128 [110.673143] Subtest bad-pitch-128: SUCCESS (0.000s) [110.799901] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [110.939871] Starting subtest: bad-pitch-256 [110.941106] Subtest bad-pitch-256: SUCCESS (0.000s) [111.066497] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [111.207108] Starting subtest: bad-pitch-32 [111.208206] Subtest bad-pitch-32: SUCCESS (0.000s) [111.333160] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [111.480485] Starting subtest: bad-pitch-63 [111.481642] Subtest bad-pitch-63: SUCCESS (0.000s) [111.599918] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [111.739397] Starting subtest: bad-pitch-65536 [111.740470] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.866532] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [112.005480] Starting subtest: bad-pitch-999 [112.006645] Subtest bad-pitch-999: SUCCESS (0.000s) [112.133900] [070/171] (893s left) kms_addfb_basic (basic) [112.270321] Starting subtest: basic [112.271487] Subtest basic: SUCCESS (0.000s) [112.399337] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [112.540146] Starting subtest: basic-x-tiled-legacy [112.541229] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.666084] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [112.806196] Starting subtest: basic-y-tiled-legacy [112.807301] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [112.932994] [073/171] (892s left) kms_addfb_basic (bo-too-small) [113.100965] Starting subtest: bo-too-small [113.102307] Subtest bo-too-small: SUCCESS (0.000s) [113.199902] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.369462] Starting subtest: bo-too-small-due-to-tiling [113.370800] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [113.466076] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [113.605369] Starting subtest: clobberred-modifier [113.606535] Subtest clobberred-modifier: SUCCESS (0.000s) [113.733212] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.875508] Starting subtest: framebuffer-vs-set-tiling [113.876582] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.999486] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [114.138892] Starting subtest: invalid-get-prop [114.140108] Subtest invalid-get-prop: SUCCESS (0.000s) [114.266198] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [114.406196] Starting subtest: invalid-get-prop-any [114.407509] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.533388] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [114.674504] Starting subtest: invalid-set-prop [114.675647] Subtest invalid-set-prop: SUCCESS (0.000s) [114.782562] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [114.922786] Starting subtest: invalid-set-prop-any [114.924206] Subtest invalid-set-prop-any: SUCCESS (0.000s) [115.049604] [081/171] (890s left) kms_addfb_basic (no-handle) [115.190634] Starting subtest: no-handle [115.191858] Subtest no-handle: SUCCESS (0.000s) [115.336047] [082/171] (890s left) kms_addfb_basic (size-max) [115.505467] Starting subtest: size-max [115.506715] Subtest size-max: SUCCESS (0.000s) [115.599215] [083/171] (890s left) kms_addfb_basic (small-bo) [115.769185] Starting subtest: small-bo [115.770370] Subtest small-bo: SUCCESS (0.000s) [115.866359] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [116.006871] Starting subtest: tile-pitch-mismatch [116.008063] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [116.133788] [085/171] (889s left) kms_addfb_basic (too-high) [116.302662] Starting subtest: too-high [116.304062] Subtest too-high: SUCCESS (0.001s) [116.399350] [086/171] (889s left) kms_addfb_basic (too-wide) [116.565502] Starting subtest: too-wide [116.566711] Subtest too-wide: SUCCESS (0.000s) [116.666301] [087/171] (889s left) kms_addfb_basic (unused-handle) [116.803797] Starting subtest: unused-handle [116.805306] Subtest unused-handle: SUCCESS (0.000s) [116.933163] [088/171] (888s left) kms_addfb_basic (unused-modifier) [117.070746] Starting subtest: unused-modifier [117.072020] Subtest unused-modifier: SUCCESS (0.000s) [117.200117] [089/171] (888s left) kms_addfb_basic (unused-offsets) [117.337479] Starting subtest: unused-offsets [117.338669] Subtest unused-offsets: SUCCESS (0.000s) [117.466423] [090/171] (888s left) kms_addfb_basic (unused-pitches) [117.604509] Starting subtest: unused-pitches [117.605708] Subtest unused-pitches: SUCCESS (0.000s) [117.733299] [091/171] (888s left) kms_busy (basic) [117.912362] Starting subtest: basic [117.913439] Starting dynamic subtest: flip [118.988418] Dynamic subtest flip: SUCCESS (1.074s) [119.007973] Starting dynamic subtest: modeset [122.867192] Dynamic subtest modeset: SUCCESS (3.873s) [122.868600] Subtest basic: SUCCESS (4.949s) [123.831535] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [124.314482] Subtest dp-hpd-fast: SKIP (0.000s) [125.188560] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [125.666868] Subtest dp-edid-read: SKIP (0.000s) [126.531294] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [127.011661] Subtest dp-crc-fast: SKIP (0.000s) [127.896620] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [128.375821] Subtest hdmi-hpd-fast: SKIP (0.000s) [129.286149] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [129.770414] Subtest hdmi-edid-read: SKIP (0.000s) [130.630067] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [131.111540] Subtest hdmi-crc-fast: SKIP (0.000s) [131.976783] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [132.456843] Subtest vga-hpd-fast: SKIP (0.000s) [133.317413] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [133.802931] Subtest vga-edid-read: SKIP (0.000s) [134.724670] [100/171] (871s left) kms_prop_blob (basic) [134.865836] Starting subtest: basic [134.867065] Subtest basic: SUCCESS (0.000s) [134.945045] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [135.115161] Starting subtest: basic-busy-flip-before-cursor-atomic [135.117324] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [135.190068] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [135.357774] Starting subtest: basic-busy-flip-before-cursor-legacy [135.360059] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [135.439910] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [135.607621] Starting subtest: basic-flip-after-cursor-atomic [136.890560] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.283s) [137.845731] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [138.013254] Starting subtest: basic-flip-after-cursor-legacy [139.306528] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.294s) [140.278596] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [140.442392] Starting subtest: basic-flip-after-cursor-varying-size [141.722410] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.280s) [142.644438] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [142.811097] Starting subtest: basic-flip-before-cursor-atomic [144.091565] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.275s) [145.022776] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [145.189828] Starting subtest: basic-flip-before-cursor-legacy [146.463955] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.274s) [147.382447] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [147.549913] Starting subtest: basic-flip-before-cursor-varying-size [148.827176] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.278s) [149.748817] [109/171] (856s left) kms_flip (basic-flip-vs-dpms) [149.896659] Starting subtest: basic-flip-vs-dpms [149.899552] Starting dynamic subtest: A-eDP1 [152.765949] Dynamic subtest A-eDP1: SUCCESS (2.867s) [152.792330] Starting dynamic subtest: B-eDP1 [155.107215] Dynamic subtest B-eDP1: SUCCESS (2.339s) [155.124208] Starting dynamic subtest: C-eDP1 [157.477168] Dynamic subtest C-eDP1: SUCCESS (2.370s) [157.479935] Subtest basic-flip-vs-dpms: SUCCESS (7.585s) [158.389728] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [158.537982] Starting subtest: basic-flip-vs-modeset [158.541129] Starting dynamic subtest: A-eDP1 [161.390373] Dynamic subtest A-eDP1: SUCCESS (2.848s) [161.406857] Starting dynamic subtest: B-eDP1 [163.740489] Dynamic subtest B-eDP1: SUCCESS (2.349s) [163.757194] Starting dynamic subtest: C-eDP1 [166.130153] Dynamic subtest C-eDP1: SUCCESS (2.387s) [166.131442] Subtest basic-flip-vs-modeset: SUCCESS (7.593s) [167.094195] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [167.246370] Starting subtest: basic-flip-vs-wf_vblank [167.250066] Starting dynamic subtest: A-eDP1 [169.556847] Dynamic subtest A-eDP1: SUCCESS (2.307s) [169.575247] Starting dynamic subtest: B-eDP1 [171.782681] Dynamic subtest B-eDP1: SUCCESS (2.225s) [171.801735] Starting dynamic subtest: C-eDP1 [174.021823] Dynamic subtest C-eDP1: SUCCESS (2.238s) [174.024909] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.779s) [175.352235] [112/171] (831s left) kms_flip (basic-plain-flip) [175.498135] Starting subtest: basic-plain-flip [175.502210] Starting dynamic subtest: A-eDP1 [177.534920] Dynamic subtest A-eDP1: SUCCESS (2.033s) [177.552512] Starting dynamic subtest: B-eDP1 [179.497857] Dynamic subtest B-eDP1: SUCCESS (1.962s) [179.517604] Starting dynamic subtest: C-eDP1 [181.482027] Dynamic subtest C-eDP1: SUCCESS (1.983s) [181.488511] Subtest basic-plain-flip: SUCCESS (5.987s) [182.775146] [113/171] (823s left) kms_force_connector_basic (force-connector-state) [182.921385] Starting subtest: force-connector-state [184.639338] Subtest force-connector-state: SUCCESS (1.719s) [185.266384] [114/171] (821s left) kms_force_connector_basic (force-edid) [185.406917] Starting subtest: force-edid [185.665082] Subtest force-edid: SUCCESS (0.253s) [185.799269] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [185.943089] Starting subtest: force-load-detect [185.945405] Subtest force-load-detect: SKIP (0.000s) [186.065759] [116/171] (820s left) kms_force_connector_basic (prune-stale-modes) [186.208274] Starting subtest: prune-stale-modes [186.514415] Subtest prune-stale-modes: SUCCESS (0.306s) [186.649153] [117/171] (819s left) kms_frontbuffer_tracking (basic) [186.824233] Starting subtest: basic [190.096555] Subtest basic: SUCCESS (3.272s) [190.248674] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [190.429659] Starting subtest: compare-crc-sanitycheck-xr24 [190.430967] Starting dynamic subtest: pipe-A-eDP-1 [191.109518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s) [191.134098] Starting dynamic subtest: pipe-B-eDP-1 [192.496043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s) [192.513019] Starting dynamic subtest: pipe-C-eDP-1 [194.037727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.540s) [194.039053] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.598s) [194.993443] [119/171] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [195.163431] Starting subtest: compare-crc-sanitycheck-nv12 [195.164524] Starting dynamic subtest: pipe-A-eDP-1 [196.083720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s) [196.109621] Starting dynamic subtest: pipe-B-eDP-1 [197.535845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s) [197.561217] Starting dynamic subtest: pipe-C-eDP-1 [199.320657] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.781s) [199.322032] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.158s) [200.243797] [120/171] (806s left) kms_pipe_crc_basic (hang-read-crc) [200.412627] Starting subtest: hang-read-crc [200.415690] Starting dynamic subtest: pipe-A-eDP-1 [202.728399] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.313s) [202.747718] Starting dynamic subtest: pipe-B-eDP-1 [205.702631] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s) [205.724158] Starting dynamic subtest: pipe-C-eDP-1 [209.032494] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.325s) [209.033759] Subtest hang-read-crc: SUCCESS (8.620s) [209.969930] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc) [210.141560] Starting subtest: nonblocking-crc [210.142811] Starting dynamic subtest: pipe-A-eDP-1 [210.995698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [211.014730] Starting dynamic subtest: pipe-B-eDP-1 [212.545484] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s) [212.566512] Starting dynamic subtest: pipe-C-eDP-1 [214.260425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.712s) [214.261670] Subtest nonblocking-crc: SUCCESS (4.120s) [215.218066] [122/171] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [215.389462] Starting subtest: nonblocking-crc-frame-sequence [215.390647] Starting dynamic subtest: pipe-A-eDP-1 [216.242960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [216.262445] Starting dynamic subtest: pipe-B-eDP-1 [217.807256] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s) [217.826856] Starting dynamic subtest: pipe-C-eDP-1 [219.524198] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.712s) [219.525423] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.137s) [220.466189] [123/171] (786s left) kms_pipe_crc_basic (read-crc) [220.635495] Starting subtest: read-crc [220.639523] Starting dynamic subtest: pipe-A-eDP-1 [221.421260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s) [221.440905] Starting dynamic subtest: pipe-B-eDP-1 [222.909859] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [222.929432] Starting dynamic subtest: pipe-C-eDP-1 [224.556624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.642s) [224.557828] Subtest read-crc: SUCCESS (3.921s) [225.521957] [124/171] (781s left) kms_pipe_crc_basic (read-crc-frame-sequence) [225.693640] Starting subtest: read-crc-frame-sequence [225.694887] Starting dynamic subtest: pipe-A-eDP-1 [226.479673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s) [226.498944] Starting dynamic subtest: pipe-B-eDP-1 [227.966808] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [227.986427] Starting dynamic subtest: pipe-C-eDP-1 [229.613494] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.643s) [229.614716] Subtest read-crc-frame-sequence: SUCCESS (3.922s) [230.578075] [125/171] (776s left) kms_psr (primary_page_flip) [230.750698] Starting subtest: primary_page_flip [234.949250] Subtest primary_page_flip: SUCCESS (4.189s) [235.890260] [126/171] (771s left) kms_psr (cursor_plane_move) [236.060749] Starting subtest: cursor_plane_move [240.216969] Subtest cursor_plane_move: SUCCESS (4.157s) [241.137975] [127/171] (765s left) kms_psr (sprite_plane_onoff) [241.308689] Starting subtest: sprite_plane_onoff [245.584737] Subtest sprite_plane_onoff: SUCCESS (4.275s) [246.513895] [128/171] (760s left) kms_psr (primary_mmap_gtt) [246.685392] Starting subtest: primary_mmap_gtt [250.872272] Subtest primary_mmap_gtt: SUCCESS (4.189s) [251.826273] [129/171] (755s left) kms_setmode (basic-clone-single-crtc) [251.969628] Starting subtest: basic-clone-single-crtc [251.973201] Subtest basic-clone-single-crtc: SKIP (0.000s) [252.059222] [130/171] (754s left) i915_pm_backlight (basic-brightness) [252.229452] Starting subtest: basic-brightness [252.323864] Starting dynamic subtest: eDP-1 [252.884434] Dynamic subtest eDP-1: SUCCESS (0.561s) [252.885590] Subtest basic-brightness: SUCCESS (0.657s) [253.811190] [131/171] (753s left) i915_pm_rpm (basic-pci-d3-state) [255.700918] Starting subtest: basic-pci-d3-state [260.108648] Subtest basic-pci-d3-state: SUCCESS (4.408s) [260.312321] [132/171] (746s left) i915_pm_rpm (basic-rte) [260.444542] Starting subtest: basic-rte [266.571820] Subtest basic-rte: SUCCESS (6.126s) [271.885975] [133/171] (735s left) i915_pm_rps (basic-api) [272.033254] Starting subtest: basic-api [272.037509] Subtest basic-api: SUCCESS (0.004s) [272.134760] [134/171] (735s left) prime_self_import (basic-llseek-bad) [272.273714] Starting subtest: basic-llseek-bad [272.278517] Subtest basic-llseek-bad: SUCCESS (0.003s) [272.384149] [135/171] (734s left) prime_self_import (basic-llseek-size) [272.521928] Starting subtest: basic-llseek-size [272.526592] Subtest basic-llseek-size: SUCCESS (0.004s) [272.634464] [136/171] (734s left) prime_self_import (basic-with_fd_dup) [272.772216] Starting subtest: basic-with_fd_dup [272.777248] Subtest basic-with_fd_dup: SUCCESS (0.005s) [272.884068] [137/171] (734s left) prime_self_import (basic-with_one_bo) [273.020908] Starting subtest: basic-with_one_bo [273.026177] Subtest basic-with_one_bo: SUCCESS (0.005s) [273.122081] [138/171] (734s left) prime_self_import (basic-with_one_bo_two_files) [273.258480] Starting subtest: basic-with_one_bo_two_files [273.263464] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [273.372588] [139/171] (733s left) prime_self_import (basic-with_two_bos) [273.509476] Starting subtest: basic-with_two_bos [273.514164] Subtest basic-with_two_bos: SUCCESS (0.005s) [273.622063] [140/171] (733s left) prime_vgem (basic-fence-flip) [273.788184] Starting subtest: basic-fence-flip [274.311664] Subtest basic-fence-flip: SUCCESS (0.524s) [274.437174] [141/171] (732s left) prime_vgem (basic-fence-mmap) [274.589187] Starting subtest: basic-fence-mmap [274.635762] Subtest basic-fence-mmap: SUCCESS (0.048s) [274.755063] [142/171] (732s left) prime_vgem (basic-fence-read) [274.906248] Starting subtest: basic-fence-read [274.978338] Subtest basic-fence-read: SUCCESS (0.074s) [275.072497] [143/171] (732s left) prime_vgem (basic-gtt) [275.220774] Starting subtest: basic-gtt [275.243796] Subtest basic-gtt: SUCCESS (0.023s) [275.354942] [144/171] (732s left) prime_vgem (basic-read) [275.504872] Starting subtest: basic-read [275.539436] Subtest basic-read: SUCCESS (0.035s) [275.639842] [145/171] (731s left) prime_vgem (basic-write) [275.805624] Starting subtest: basic-write [275.847450] Subtest basic-write: SUCCESS (0.042s) [275.938180] [146/171] (731s left) vgem_basic (setversion) [276.098553] Starting subtest: setversion [276.102533] Subtest setversion: SUCCESS (0.000s) [276.170193] [147/171] (731s left) vgem_basic (create) [276.313081] Starting subtest: create [276.314369] Subtest create: SUCCESS (0.000s) [276.385079] [148/171] (731s left) vgem_basic (debugfs) [276.529758] Starting subtest: debugfs [276.531063] Subtest debugfs: SUCCESS (0.001s) [276.606076] [149/171] (731s left) vgem_basic (dmabuf-export) [276.763585] Starting subtest: dmabuf-export [276.768477] Subtest dmabuf-export: SUCCESS (0.003s) [276.873043] [150/171] (730s left) vgem_basic (dmabuf-fence) [277.015969] Starting subtest: dmabuf-fence [277.017210] Subtest dmabuf-fence: SUCCESS (0.001s) [277.085093] [151/171] (730s left) vgem_basic (dmabuf-fence-before) [277.231178] Starting subtest: dmabuf-fence-before [277.232353] Subtest dmabuf-fence-before: SUCCESS (0.000s) [277.301896] [152/171] (730s left) vgem_basic (dmabuf-mmap) [277.449065] Starting subtest: dmabuf-mmap [277.473463] Subtest dmabuf-mmap: SUCCESS (0.026s) [277.551616] [153/171] (730s left) vgem_basic (mmap) [277.698343] Starting subtest: mmap [277.714118] Subtest mmap: SUCCESS (0.017s) [277.785523] [154/171] (729s left) vgem_basic (second-client) [277.931539] Starting subtest: second-client [277.965981] Subtest second-client: SUCCESS (0.033s) [278.036176] [155/171] (729s left) vgem_basic (sysfs) [278.199806] Starting subtest: sysfs [278.201021] Subtest sysfs: SUCCESS (0.001s) [278.268572] [156/171] (729s left) core_hotunplug (unbind-rebind) [278.448477] Starting subtest: unbind-rebind [280.937188] Subtest unbind-rebind: SUCCESS (2.489s) [280.978372] [157/171] (726s left) vgem_basic (unload) [281.118524] Starting subtest: unload [310.148678] Subtest unload: SUCCESS (29.020s) [310.277929] [158/171] (697s left) i915_module_load (reload) [310.416839] Starting subtest: reload [313.997438] Subtest reload: SUCCESS (3.580s) [314.030468] [159/171] (693s left) gem_lmem_swapping (basic) [314.182890] Subtest basic: SKIP (0.000s) [314.232526] [160/171] (693s left) gem_lmem_swapping (parallel-random-engines) [314.380273] Subtest parallel-random-engines: SKIP (0.000s) [314.431928] [161/171] (693s left) gem_lmem_swapping (random-engines) [314.580381] Subtest random-engines: SKIP (0.000s) [314.632721] [162/171] (693s left) gem_lmem_swapping (verify-random) [314.778556] Subtest verify-random: SKIP (0.000s) [314.835304] [163/171] (693s left) i915_pm_rpm (module-reload) [327.332462] Starting subtest: module-reload [362.226198] Subtest module-reload: SUCCESS (34.886s) [362.254432] [164/171] (645s left) i915_selftest (live) [362.398891] Starting subtest: live [362.400521] Starting dynamic subtest: sanitycheck [364.265637] Dynamic subtest sanitycheck: SUCCESS (1.857s) [364.280029] Starting dynamic subtest: uncore [366.092469] Dynamic subtest uncore: SUCCESS (1.823s) [366.107130] Starting dynamic subtest: workarounds [368.164460] Dynamic subtest workarounds: SUCCESS (2.069s) [368.179069] Starting dynamic subtest: gt_engines [370.459410] Dynamic subtest gt_engines: SUCCESS (2.292s) [370.474121] Starting dynamic subtest: gt_timelines [383.156617] Dynamic subtest gt_timelines: SUCCESS (12.694s) [383.171324] Starting dynamic subtest: gt_contexts [385.155637] Dynamic subtest gt_contexts: SUCCESS (1.996s) [385.169962] Starting dynamic subtest: gt_lrc [389.556555] Dynamic subtest gt_lrc: SUCCESS (4.397s) [389.571205] Starting dynamic subtest: gt_mocs [391.457485] Dynamic subtest gt_mocs: SUCCESS (1.898s) [391.472045] Starting dynamic subtest: gt_pm [396.553471] Dynamic subtest gt_pm: SUCCESS (5.093s) [396.568188] Starting dynamic subtest: gt_heartbeat [398.498982] Dynamic subtest gt_heartbeat: SUCCESS (1.942s) [398.513769] Starting dynamic subtest: gt_tlb [401.667515] Dynamic subtest gt_tlb: SUCCESS (3.165s) [401.682243] Starting dynamic subtest: requests [409.281639] Dynamic subtest requests: SUCCESS (7.611s) [409.296407] Starting dynamic subtest: migrate [413.947547] Dynamic subtest migrate: SUCCESS (4.662s) [413.962232] Starting dynamic subtest: active [415.842398] Dynamic subtest active: SUCCESS (1.891s) [415.857089] Starting dynamic subtest: objects [419.217807] Dynamic subtest objects: SUCCESS (3.372s) [419.232515] Starting dynamic subtest: mman [426.180676] Dynamic subtest mman: SUCCESS (6.960s) [426.195453] Starting dynamic subtest: dmabuf [428.081688] Dynamic subtest dmabuf: SUCCESS (1.898s) [428.096657] Starting dynamic subtest: vma [429.907268] Dynamic subtest vma: SUCCESS (1.822s) [429.922243] Starting dynamic subtest: coherency [434.409494] Dynamic subtest coherency: SUCCESS (4.499s) [434.424213] Starting dynamic subtest: gtt [443.783433] Dynamic subtest gtt: SUCCESS (9.371s) [443.798243] Starting dynamic subtest: gem [445.738560] Dynamic subtest gem: SUCCESS (1.952s) [445.753468] Starting dynamic subtest: evict [449.575707] Dynamic subtest evict: SUCCESS (3.842s) [449.592845] Starting dynamic subtest: hugepages [457.337881] Dynamic subtest hugepages: SUCCESS (7.751s) [457.353025] Starting dynamic subtest: gem_contexts [472.610329] Dynamic subtest gem_contexts: SUCCESS (15.269s) [472.625787] Starting dynamic subtest: client [474.464883] Dynamic subtest client: SUCCESS (1.851s) [474.480268] Starting dynamic subtest: gem_migrate [476.314744] Dynamic subtest gem_migrate: SUCCESS (1.846s) [476.329670] Starting dynamic subtest: reset [481.730051] Dynamic subtest reset: SUCCESS (5.411s) [481.745144] Starting dynamic subtest: memory_region [483.541455] Dynamic subtest memory_region: SUCCESS (1.808s) [483.556856] Starting dynamic subtest: hangcheck [507.970532] Dynamic subtest hangcheck: SUCCESS (24.426s) [507.985911] Starting dynamic subtest: execlists [518.092807] Dynamic subtest execlists: SUCCESS (10.119s) [518.107886] Starting dynamic subtest: ring_submission [519.918513] Dynamic subtest ring_submission: SUCCESS (1.822s) [519.934041] Starting dynamic subtest: perf [521.852908] Dynamic subtest perf: SUCCESS (1.931s) [521.868266] Starting dynamic subtest: slpc [523.666585] Dynamic subtest slpc: SUCCESS (1.810s) [523.681802] Starting dynamic subtest: guc [525.456670] Dynamic subtest guc: SUCCESS (1.786s) [525.472036] Starting dynamic subtest: guc_multi_lrc [527.338438] Dynamic subtest guc_multi_lrc: SUCCESS (1.879s) [527.353893] Starting dynamic subtest: guc_hang [529.183437] Dynamic subtest guc_hang: SUCCESS (1.842s) [529.198395] Starting dynamic subtest: late_gt_pm [531.096389] Dynamic subtest late_gt_pm: SUCCESS (1.910s) [531.097817] Subtest live: SUCCESS (168.691s) [531.296044] [165/171] (476s left) dmabuf (all-tests) [531.437821] Starting subtest: all-tests [531.439359] Starting dynamic subtest: sanitycheck [531.507896] Dynamic subtest sanitycheck: SUCCESS (0.068s) [531.527790] Starting dynamic subtest: dma_fence [531.702077] Dynamic subtest dma_fence: SUCCESS (0.190s) [531.720595] Starting dynamic subtest: dma_fence_chain [549.612169] Dynamic subtest dma_fence_chain: SUCCESS (17.898s) [549.624494] Starting dynamic subtest: dma_fence_unwrap [549.682781] Dynamic subtest dma_fence_unwrap: SUCCESS (0.075s) [549.701400] Starting dynamic subtest: dma_resv [549.757752] Dynamic subtest dma_resv: SUCCESS (0.071s) [549.759988] Subtest all-tests: SUCCESS (18.321s) [549.792854] [166/171] (458s left) i915_suspend (basic-s2idle-without-i915) [549.933159] Starting subtest: basic-s2idle-without-i915 [573.908485] Subtest basic-s2idle-without-i915: SUCCESS (8.330s) [574.200559] [167/171] (449s left) i915_suspend (basic-s3-without-i915) [574.341040] Starting subtest: basic-s3-without-i915 [598.089583] Subtest basic-s3-without-i915: SUCCESS (7.154s) [598.418306] [168/171] (442s left) gem_exec_suspend (basic-s0) [598.579286] Starting subtest: basic-S0 [598.580530] Starting dynamic subtest: smem [618.111963] Dynamic subtest smem: SUCCESS (3.878s) [618.113153] Subtest basic-S0: SUCCESS (3.880s) [618.262668] [169/171] (437s left) gem_exec_suspend (basic-s3) [618.415989] Starting subtest: basic-S3 [618.417105] Starting dynamic subtest: smem [637.323986] Dynamic subtest smem: SUCCESS (3.905s) [637.325252] Subtest basic-S3: SUCCESS (3.907s) [637.542537] [170/171] (433s left) kms_chamelium_hpd (common-hpd-after-suspend) [638.029091] Subtest common-hpd-after-suspend: SKIP (0.000s) [638.904740] [171/171] (432s left) kms_pipe_crc_basic (suspend-read-crc) [639.070054] Starting subtest: suspend-read-crc [639.071137] Starting dynamic subtest: pipe-A-eDP-1 [657.027680] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.429s) [657.050476] Starting dynamic subtest: pipe-B-eDP-1 [674.999036] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.096s) [675.019644] Starting dynamic subtest: pipe-C-eDP-1 [693.989287] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.240s) [693.990538] Subtest suspend-read-crc: SUCCESS (8.777s) [694.901679] Closing watchdogs Done.