[36.670116] Initializing watchdogs [36.670220] /dev/watchdog0 [36.676303] [001/171] (960s left) i915_module_load (load) [36.745222] Starting subtest: load [38.971477] Subtest load: SUCCESS (2.226s) [38.998291] [002/171] (958s left) core_auth (basic-auth) [39.132519] Starting subtest: basic-auth [39.133726] Subtest basic-auth: SUCCESS (0.001s) [39.240972] [003/171] (957s left) debugfs_test (read_all_entries) [39.387992] Starting subtest: read_all_entries [39.722741] Subtest read_all_entries: SUCCESS (0.337s) [39.812520] [004/171] (957s left) debugfs_test (basic-hwmon) [39.913361] Starting subtest: basic-hwmon [39.915364] Subtest basic-hwmon: SKIP (0.000s) [40.018134] [005/171] (957s left) fbdev (eof) [40.133664] Starting subtest: eof [40.134996] Subtest eof: SUCCESS (0.000s) [40.192468] [006/171] (957s left) fbdev (info) [40.274144] Starting subtest: info [40.275100] Subtest info: SUCCESS (0.000s) [40.342155] [007/171] (956s left) fbdev (nullptr) [40.432612] Starting subtest: nullptr [40.434172] Subtest nullptr: SUCCESS (0.000s) [40.490281] [008/171] (956s left) fbdev (read) [40.565765] Starting subtest: read [47.926537] Subtest read: SUCCESS (7.326s) [47.961767] [009/171] (949s left) fbdev (write) [48.024374] Starting subtest: write [51.720768] Subtest write: SUCCESS (3.662s) [51.754531] [010/171] (945s left) gem_basic (bad-close) [51.808114] Starting subtest: bad-close [51.809620] Subtest bad-close: SUCCESS (0.000s) [51.871125] [011/171] (945s left) gem_basic (create-close) [51.929167] Starting subtest: create-close [51.930639] Subtest create-close: SUCCESS (0.000s) [52.020906] [012/171] (945s left) gem_basic (create-fd-close) [52.079171] Starting subtest: create-fd-close [52.080705] Subtest create-fd-close: SUCCESS (0.000s) [52.170757] [013/171] (945s left) gem_busy (busy@all-engines) [52.236568] Starting subtest: busy [52.237723] Starting dynamic subtest: all-engines [52.269549] Dynamic subtest all-engines: SUCCESS (0.033s) [52.270321] Subtest busy: SUCCESS (0.033s) [52.628139] [014/171] (944s left) gem_close_race (basic-process) [52.692217] Starting subtest: basic-process [52.725101] Subtest basic-process: SUCCESS (0.032s) [52.909380] [015/171] (944s left) gem_close_race (basic-threads) [52.972596] Starting subtest: basic-threads [54.097789] Subtest basic-threads: SUCCESS (1.125s) [54.293139] [016/171] (943s left) gem_ctx_create (basic) [54.391266] Starting subtest: basic [54.392287] Subtest basic: SUCCESS (0.000s) [54.583537] [017/171] (942s left) gem_ctx_create (basic-files) [54.667769] Starting subtest: basic-files [56.682646] Subtest basic-files: SUCCESS (2.015s) [57.032777] [018/171] (940s left) gem_ctx_exec (basic) [57.111148] Starting subtest: basic [57.114753] Subtest basic: SUCCESS (0.004s) [57.232256] [019/171] (940s left) gem_exec_basic (basic) [57.310491] Starting subtest: basic [57.311465] Starting dynamic subtest: rcs0-smem [57.312396] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [57.319502] Starting dynamic subtest: bcs0-smem [57.320479] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [57.326635] Starting dynamic subtest: vcs0-smem [57.327499] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [57.334102] Starting dynamic subtest: vecs0-smem [57.334951] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [57.335772] Subtest basic: SUCCESS (0.004s) [57.506228] [020/171] (939s left) gem_exec_create (basic) [57.580297] Starting subtest: basic [57.581264] Starting dynamic subtest: smem [59.676781] Dynamic subtest smem: SUCCESS (2.095s) [59.678309] Subtest basic: SUCCESS (2.096s) [59.864120] [021/171] (937s left) gem_exec_fence (basic-busy) [60.060562] Starting subtest: basic-busy [60.061973] Starting dynamic subtest: rcs0 [60.112638] Dynamic subtest rcs0: SUCCESS (0.060s) [60.123843] Starting dynamic subtest: bcs0 [60.164955] Dynamic subtest bcs0: SUCCESS (0.052s) [60.175196] Starting dynamic subtest: vcs0 [60.217863] Dynamic subtest vcs0: SUCCESS (0.053s) [60.228813] Starting dynamic subtest: vecs0 [60.269220] Dynamic subtest vecs0: SUCCESS (0.051s) [60.270753] Subtest basic-busy: SUCCESS (0.217s) [60.793518] [022/171] (936s left) gem_exec_fence (basic-wait) [60.968269] Starting subtest: basic-wait [60.969591] Starting dynamic subtest: rcs0 [61.018633] Dynamic subtest rcs0: SUCCESS (0.058s) [61.029245] Starting dynamic subtest: bcs0 [61.071810] Dynamic subtest bcs0: SUCCESS (0.053s) [61.082294] Starting dynamic subtest: vcs0 [61.125209] Dynamic subtest vcs0: SUCCESS (0.053s) [61.136275] Starting dynamic subtest: vecs0 [61.171867] Dynamic subtest vecs0: SUCCESS (0.047s) [61.173164] Subtest basic-wait: SUCCESS (0.212s) [61.664416] [023/171] (935s left) gem_exec_fence (basic-await) [61.848095] Starting subtest: basic-await [61.849106] Starting dynamic subtest: rcs0 [61.919982] Dynamic subtest rcs0: SUCCESS (0.080s) [61.930871] Starting dynamic subtest: bcs0 [61.999905] Dynamic subtest bcs0: SUCCESS (0.079s) [62.017088] Starting dynamic subtest: vcs0 [62.087543] Dynamic subtest vcs0: SUCCESS (0.087s) [62.104790] Starting dynamic subtest: vecs0 [62.174631] Dynamic subtest vecs0: SUCCESS (0.087s) [62.176297] Subtest basic-await: SUCCESS (0.334s) [62.668335] [024/171] (934s left) gem_exec_fence (nb-await) [62.848844] Starting subtest: nb-await [62.849970] Starting dynamic subtest: rcs0 [62.908132] Dynamic subtest rcs0: SUCCESS (0.064s) [62.915812] Starting dynamic subtest: bcs0 [62.969622] Dynamic subtest bcs0: SUCCESS (0.061s) [62.985087] Starting dynamic subtest: vcs0 [63.033872] Dynamic subtest vcs0: SUCCESS (0.064s) [63.038715] Starting dynamic subtest: vecs0 [63.092160] Dynamic subtest vecs0: SUCCESS (0.058s) [63.093830] Subtest nb-await: SUCCESS (0.249s) [63.581967] [025/171] (933s left) gem_exec_gttfill (basic) [63.642999] Starting subtest: basic [67.592714] Subtest basic: SUCCESS (3.949s) [67.785376] [026/171] (929s left) gem_exec_parallel (engines) [67.931126] Starting subtest: engines [67.932203] Starting dynamic subtest: basic [73.538979] Dynamic subtest basic: SUCCESS (5.607s) [73.551594] Starting dynamic subtest: contexts [77.514191] Dynamic subtest contexts: SUCCESS (3.967s) [77.523320] Starting dynamic subtest: fds [82.040538] Dynamic subtest fds: SUCCESS (4.526s) [82.050192] Starting dynamic subtest: userptr [85.499643] Dynamic subtest userptr: SUCCESS (3.466s) [85.500884] Subtest engines: SUCCESS (17.567s) [85.687867] [027/171] (911s left) gem_exec_store (basic) [85.758899] Starting subtest: basic [85.853293] Subtest basic: SUCCESS (0.093s) [86.040612] [028/171] (911s left) gem_flink_basic (bad-flink) [86.098112] Starting subtest: bad-flink [86.098967] Subtest bad-flink: SUCCESS (0.000s) [86.157647] [029/171] (911s left) gem_flink_basic (bad-open) [86.217602] Starting subtest: bad-open [86.218458] Subtest bad-open: SUCCESS (0.000s) [86.290675] [030/171] (911s left) gem_flink_basic (basic) [86.354028] Starting subtest: basic [86.354798] Subtest basic: SUCCESS (0.000s) [86.441156] [031/171] (911s left) gem_flink_basic (double-flink) [86.504855] Starting subtest: double-flink [86.505769] Subtest double-flink: SUCCESS (0.000s) [86.591397] [032/171] (911s left) gem_flink_basic (flink-lifetime) [86.655899] Starting subtest: flink-lifetime [86.657771] Subtest flink-lifetime: SUCCESS (0.001s) [86.741444] [033/171] (910s left) gem_huc_copy (huc-copy) [86.809038] Starting subtest: huc-copy [86.812032] Subtest huc-copy: SUCCESS (0.003s) [86.916381] [034/171] (910s left) gem_linear_blits (basic) [87.075241] Starting subtest: basic [87.082684] Subtest basic: SUCCESS (0.008s) [87.221396] [035/171] (910s left) gem_mmap (basic) [87.327386] Starting subtest: basic [87.331263] Subtest basic: SUCCESS (0.000s) [87.427490] [036/171] (910s left) gem_mmap_gtt (basic) [87.490193] Starting subtest: basic [87.491180] Subtest basic: SUCCESS (0.001s) [87.568366] [037/171] (910s left) gem_render_linear_blits (basic) [87.636927] Starting subtest: basic [87.673523] Subtest basic: SUCCESS (0.036s) [87.762022] [038/171] (909s left) gem_render_tiled_blits (basic) [87.830330] Starting subtest: basic [87.869946] Subtest basic: SUCCESS (0.039s) [87.960802] [039/171] (909s left) gem_ringfill (basic-all) [88.277978] Starting subtest: basic-all [89.418413] Subtest basic-all: SUCCESS (1.133s) [89.527355] [040/171] (908s left) gem_softpin (allocator-basic) [89.608353] Starting subtest: allocator-basic [89.713411] Subtest allocator-basic: SUCCESS (0.105s) [89.834713] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [89.910705] Starting subtest: allocator-basic-reserve [90.012919] Subtest allocator-basic-reserve: SUCCESS (0.102s) [90.131435] [042/171] (907s left) gem_softpin (safe-alignment) [90.204629] Starting subtest: safe-alignment [90.215542] Subtest safe-alignment: SUCCESS (0.011s) [90.328746] [043/171] (907s left) gem_sync (basic-all) [90.407705] Starting subtest: basic-all [92.601075] Subtest basic-all: SUCCESS (2.192s) [92.791642] [044/171] (905s left) gem_sync (basic-each) [92.852786] Starting subtest: basic-each [95.611143] Subtest basic-each: SUCCESS (2.757s) [95.802602] [045/171] (902s left) gem_tiled_blits (basic) [95.942214] Starting subtest: basic [95.961677] Subtest basic: SUCCESS (0.019s) [96.082897] [046/171] (901s left) gem_tiled_fence_blits (basic) [96.280568] Starting subtest: basic [96.300844] Subtest basic: SUCCESS (0.021s) [96.420547] [047/171] (901s left) gem_tiled_pread_basic [96.564480] [048/171] (901s left) gem_wait (busy@all-engines) [96.637324] Starting subtest: busy [96.638311] Starting dynamic subtest: all-engines [97.190214] Dynamic subtest all-engines: SUCCESS (0.552s) [97.191785] Subtest busy: SUCCESS (0.552s) [97.408358] [049/171] (900s left) gem_wait (wait@all-engines) [97.480177] Starting subtest: wait [97.481027] Starting dynamic subtest: all-engines [98.544217] Dynamic subtest all-engines: SUCCESS (1.063s) [98.545744] Subtest wait: SUCCESS (1.063s) [98.751814] [050/171] (899s left) i915_getparams_basic (basic-eu-total) [98.799245] Starting subtest: basic-eu-total [98.800754] Subtest basic-eu-total: SUCCESS (0.000s) [98.867385] [051/171] (899s left) i915_getparams_basic (basic-subslice-total) [98.919451] Starting subtest: basic-subslice-total [98.921031] Subtest basic-subslice-total: SUCCESS (0.000s) [98.980723] [052/171] (899s left) i915_hangman (error-state-basic) [99.036269] Starting subtest: error-state-basic [99.151383] Subtest error-state-basic: SUCCESS (0.115s) [99.234240] [053/171] (898s left) i915_pciid [99.351698] [054/171] (898s left) kms_addfb_basic (addfb25-bad-modifier) [99.434457] Starting subtest: addfb25-bad-modifier [99.435244] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [99.553249] [055/171] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [99.630508] Starting subtest: addfb25-framebuffer-vs-set-tiling [99.631537] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [99.757282] [056/171] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [99.837697] Starting subtest: addfb25-modifier-no-flag [99.838526] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [99.964215] [057/171] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [100.051484] Starting subtest: addfb25-x-tiled-legacy [100.052393] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [100.182367] [058/171] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [100.271383] Starting subtest: addfb25-x-tiled-mismatch-legacy [100.272403] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [100.404555] [059/171] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [100.510659] Starting subtest: addfb25-yf-tiled-legacy [100.511509] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [100.627075] [060/171] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy) [100.738229] Starting subtest: addfb25-y-tiled-legacy [100.739131] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [100.843408] [061/171] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [100.956094] Starting subtest: addfb25-y-tiled-small-legacy [100.956956] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [101.071701] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [101.151108] Starting subtest: bad-pitch-0 [101.152072] Subtest bad-pitch-0: SUCCESS (0.000s) [101.297130] [063/171] (896s left) kms_addfb_basic (bad-pitch-1024) [101.375333] Starting subtest: bad-pitch-1024 [101.376425] Subtest bad-pitch-1024: SUCCESS (0.000s) [101.524983] [064/171] (896s left) kms_addfb_basic (bad-pitch-128) [101.602752] Starting subtest: bad-pitch-128 [101.603699] Subtest bad-pitch-128: SUCCESS (0.000s) [101.753706] [065/171] (896s left) kms_addfb_basic (bad-pitch-256) [101.832424] Starting subtest: bad-pitch-256 [101.833331] Subtest bad-pitch-256: SUCCESS (0.000s) [101.981688] [066/171] (896s left) kms_addfb_basic (bad-pitch-32) [102.062257] Starting subtest: bad-pitch-32 [102.063217] Subtest bad-pitch-32: SUCCESS (0.000s) [102.213502] [067/171] (896s left) kms_addfb_basic (bad-pitch-63) [102.293169] Starting subtest: bad-pitch-63 [102.294050] Subtest bad-pitch-63: SUCCESS (0.000s) [102.441901] [068/171] (895s left) kms_addfb_basic (bad-pitch-65536) [102.522239] Starting subtest: bad-pitch-65536 [102.523135] Subtest bad-pitch-65536: SUCCESS (0.000s) [102.675292] [069/171] (895s left) kms_addfb_basic (bad-pitch-999) [102.755301] Starting subtest: bad-pitch-999 [102.756178] Subtest bad-pitch-999: SUCCESS (0.000s) [102.908541] [070/171] (895s left) kms_addfb_basic (basic) [102.993162] Starting subtest: basic [102.994194] Subtest basic: SUCCESS (0.000s) [103.146991] [071/171] (895s left) kms_addfb_basic (basic-x-tiled-legacy) [103.282129] Starting subtest: basic-x-tiled-legacy [103.283062] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [103.387031] [072/171] (894s left) kms_addfb_basic (basic-y-tiled-legacy) [103.520275] Starting subtest: basic-y-tiled-legacy [103.521212] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [103.618649] [073/171] (894s left) kms_addfb_basic (bo-too-small) [103.716132] Starting subtest: bo-too-small [103.717078] Subtest bo-too-small: SUCCESS (0.000s) [103.852974] [074/171] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [103.952082] Starting subtest: bo-too-small-due-to-tiling [103.953108] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [104.082843] [075/171] (894s left) kms_addfb_basic (clobberred-modifier) [104.162163] Starting subtest: clobberred-modifier [104.163110] Subtest clobberred-modifier: SUCCESS (0.000s) [104.317819] [076/171] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [104.451179] Starting subtest: framebuffer-vs-set-tiling [104.452143] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.548934] [077/171] (893s left) kms_addfb_basic (invalid-get-prop) [104.684419] Starting subtest: invalid-get-prop [104.685324] Subtest invalid-get-prop: SUCCESS (0.000s) [104.778541] [078/171] (893s left) kms_addfb_basic (invalid-get-prop-any) [104.912598] Starting subtest: invalid-get-prop-any [104.913517] Subtest invalid-get-prop-any: SUCCESS (0.000s) [105.001100] [079/171] (893s left) kms_addfb_basic (invalid-set-prop) [105.136954] Starting subtest: invalid-set-prop [105.138091] Subtest invalid-set-prop: SUCCESS (0.000s) [105.241892] [080/171] (893s left) kms_addfb_basic (invalid-set-prop-any) [105.376735] Starting subtest: invalid-set-prop-any [105.377671] Subtest invalid-set-prop-any: SUCCESS (0.000s) [105.473242] [081/171] (893s left) kms_addfb_basic (no-handle) [105.552764] Starting subtest: no-handle [105.553709] Subtest no-handle: SUCCESS (0.000s) [105.713841] [082/171] (892s left) kms_addfb_basic (size-max) [105.811646] Starting subtest: size-max [105.812565] Subtest size-max: SUCCESS (0.000s) [105.951743] [083/171] (892s left) kms_addfb_basic (small-bo) [106.049112] Starting subtest: small-bo [106.049982] Subtest small-bo: SUCCESS (0.000s) [106.177352] [084/171] (892s left) kms_addfb_basic (tile-pitch-mismatch) [106.310414] Starting subtest: tile-pitch-mismatch [106.311395] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.412731] [085/171] (892s left) kms_addfb_basic (too-high) [106.511548] Starting subtest: too-high [106.512684] Subtest too-high: SUCCESS (0.001s) [106.647196] [086/171] (891s left) kms_addfb_basic (too-wide) [106.748638] Starting subtest: too-wide [106.749613] Subtest too-wide: SUCCESS (0.000s) [106.879568] [087/171] (891s left) kms_addfb_basic (unused-handle) [106.960089] Starting subtest: unused-handle [106.960965] Subtest unused-handle: SUCCESS (0.000s) [107.113637] [088/171] (891s left) kms_addfb_basic (unused-modifier) [107.193158] Starting subtest: unused-modifier [107.194102] Subtest unused-modifier: SUCCESS (0.000s) [107.344215] [089/171] (891s left) kms_addfb_basic (unused-offsets) [107.424235] Starting subtest: unused-offsets [107.425155] Subtest unused-offsets: SUCCESS (0.000s) [107.578626] [090/171] (891s left) kms_addfb_basic (unused-pitches) [107.655896] Starting subtest: unused-pitches [107.656854] Subtest unused-pitches: SUCCESS (0.000s) [107.810706] [091/171] (890s left) kms_busy (basic) [107.918103] Starting subtest: basic [107.920185] Starting dynamic subtest: flip [108.806855] Dynamic subtest flip: SUCCESS (0.887s) [108.817060] Starting dynamic subtest: modeset [112.693726] Dynamic subtest modeset: SUCCESS (3.879s) [112.695071] Subtest basic: SUCCESS (4.768s) [113.634859] [092/171] (885s left) kms_chamelium_hpd (dp-hpd-fast) [114.018127] Subtest dp-hpd-fast: SKIP (0.000s) [114.937814] [093/171] (883s left) kms_chamelium_edid (dp-edid-read) [115.322415] Subtest dp-edid-read: SKIP (0.000s) [116.216378] [094/171] (882s left) kms_chamelium_frames (dp-crc-fast) [116.606060] Subtest dp-crc-fast: SKIP (0.000s) [117.496448] [095/171] (881s left) kms_chamelium_hpd (hdmi-hpd-fast) [117.882537] Subtest hdmi-hpd-fast: SKIP (0.000s) [118.778208] [096/171] (880s left) kms_chamelium_edid (hdmi-edid-read) [119.172435] Subtest hdmi-edid-read: SKIP (0.000s) [120.056988] [097/171] (878s left) kms_chamelium_frames (hdmi-crc-fast) [120.446330] Subtest hdmi-crc-fast: SKIP (0.000s) [121.338245] [098/171] (877s left) kms_chamelium_hpd (vga-hpd-fast) [121.706816] Subtest vga-hpd-fast: SKIP (0.000s) [122.617659] [099/171] (876s left) kms_chamelium_edid (vga-edid-read) [123.004574] Subtest vga-edid-read: SKIP (0.000s) [123.898383] [100/171] (874s left) kms_prop_blob (basic) [123.949908] Starting subtest: basic [123.950678] Subtest basic: SUCCESS (0.000s) [124.025929] [101/171] (874s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [124.132074] Starting subtest: basic-busy-flip-before-cursor-atomic [124.133644] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [124.231941] [102/171] (874s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [124.333788] Starting subtest: basic-busy-flip-before-cursor-legacy [124.335403] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [124.450299] [103/171] (874s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [124.552667] Starting subtest: basic-flip-after-cursor-atomic [125.775135] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.221s) [126.689484] [104/171] (872s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [126.799339] Starting subtest: basic-flip-after-cursor-legacy [128.022454] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.223s) [128.930828] [105/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [129.040151] Starting subtest: basic-flip-after-cursor-varying-size [130.258134] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.218s) [131.190963] [106/171] (867s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [131.300203] Starting subtest: basic-flip-before-cursor-atomic [132.522698] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.222s) [133.474752] [107/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [133.582114] Starting subtest: basic-flip-before-cursor-legacy [134.807061] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.223s) [135.713492] [108/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [135.822952] Starting subtest: basic-flip-before-cursor-varying-size [137.046783] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.223s) [137.971952] [109/171] (861s left) kms_flip (basic-flip-vs-dpms) [138.036627] Starting subtest: basic-flip-vs-dpms [138.038428] Starting dynamic subtest: A-eDP1 [140.850483] Dynamic subtest A-eDP1: SUCCESS (2.812s) [140.867452] Starting dynamic subtest: B-eDP1 [143.307402] Dynamic subtest B-eDP1: SUCCESS (2.457s) [143.316993] Starting dynamic subtest: C-eDP1 [145.712054] Dynamic subtest C-eDP1: SUCCESS (2.404s) [145.713733] Subtest basic-flip-vs-dpms: SUCCESS (7.678s) [146.609865] [110/171] (852s left) kms_flip (basic-flip-vs-modeset) [146.671594] Starting subtest: basic-flip-vs-modeset [146.673535] Starting dynamic subtest: A-eDP1 [149.478634] Dynamic subtest A-eDP1: SUCCESS (2.804s) [149.496411] Starting dynamic subtest: B-eDP1 [151.914392] Dynamic subtest B-eDP1: SUCCESS (2.434s) [151.930879] Starting dynamic subtest: C-eDP1 [154.340734] Dynamic subtest C-eDP1: SUCCESS (2.427s) [154.343556] Subtest basic-flip-vs-modeset: SUCCESS (7.672s) [155.298282] [111/171] (843s left) kms_flip (basic-flip-vs-wf_vblank) [155.361848] Starting subtest: basic-flip-vs-wf_vblank [155.363701] Starting dynamic subtest: A-eDP1 [157.647068] Dynamic subtest A-eDP1: SUCCESS (2.283s) [157.656712] Starting dynamic subtest: B-eDP1 [159.887582] Dynamic subtest B-eDP1: SUCCESS (2.239s) [159.896585] Starting dynamic subtest: C-eDP1 [162.108695] Dynamic subtest C-eDP1: SUCCESS (2.221s) [162.109857] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.749s) [163.427364] [112/171] (835s left) kms_flip (basic-plain-flip) [163.486702] Starting subtest: basic-plain-flip [163.487442] Starting dynamic subtest: A-eDP1 [165.491357] Dynamic subtest A-eDP1: SUCCESS (2.003s) [165.500653] Starting dynamic subtest: B-eDP1 [167.477425] Dynamic subtest B-eDP1: SUCCESS (1.985s) [167.486808] Starting dynamic subtest: C-eDP1 [169.439338] Dynamic subtest C-eDP1: SUCCESS (1.961s) [169.440379] Subtest basic-plain-flip: SUCCESS (5.955s) [170.746720] [113/171] (828s left) kms_force_connector_basic (force-connector-state) [170.798032] Starting subtest: force-connector-state [171.571437] Subtest force-connector-state: SUCCESS (0.773s) [172.385684] [114/171] (826s left) kms_force_connector_basic (force-edid) [172.441237] Starting subtest: force-edid [172.460998] Subtest force-edid: SUCCESS (0.025s) [172.554473] [115/171] (826s left) kms_force_connector_basic (force-load-detect) [172.602802] Starting subtest: force-load-detect [172.604327] Subtest force-load-detect: SKIP (0.000s) [172.687601] [116/171] (826s left) kms_force_connector_basic (prune-stale-modes) [172.735913] Starting subtest: prune-stale-modes [172.759273] Subtest prune-stale-modes: SUCCESS (0.024s) [172.838131] [117/171] (826s left) kms_frontbuffer_tracking (basic) [172.901553] Starting subtest: basic [177.085452] Subtest basic: SUCCESS (4.184s) [177.180185] [118/171] (821s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [177.246908] Starting subtest: compare-crc-sanitycheck [177.247717] Starting dynamic subtest: pipe-A-eDP-1 [177.920135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.672s) [177.939747] Starting dynamic subtest: pipe-B-eDP-1 [179.336096] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s) [179.355915] Starting dynamic subtest: pipe-C-eDP-1 [180.705761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s) [180.706608] Subtest compare-crc-sanitycheck: SUCCESS (3.459s) [181.668276] [119/171] (817s left) kms_pipe_crc_basic (hang-read-crc) [181.749321] Starting subtest: hang-read-crc [181.750121] Starting dynamic subtest: pipe-A-eDP-1 [184.081566] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.329s) [184.097309] Starting dynamic subtest: pipe-B-eDP-1 [187.121721] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.038s) [187.138867] Starting dynamic subtest: pipe-C-eDP-1 [190.084963] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.961s) [190.085968] Subtest hang-read-crc: SUCCESS (8.336s) [191.020585] [120/171] (808s left) kms_pipe_crc_basic (nonblocking-crc) [191.106827] Starting subtest: nonblocking-crc [191.107743] Starting dynamic subtest: pipe-A-eDP-1 [191.946637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s) [191.956438] Starting dynamic subtest: pipe-B-eDP-1 [193.527503] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s) [193.542857] Starting dynamic subtest: pipe-C-eDP-1 [195.066322] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.538s) [195.067255] Subtest nonblocking-crc: SUCCESS (3.960s) [196.002887] [121/171] (803s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [196.085853] Starting subtest: nonblocking-crc-frame-sequence [196.086739] Starting dynamic subtest: pipe-A-eDP-1 [196.944667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s) [196.951797] Starting dynamic subtest: pipe-B-eDP-1 [198.540125] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s) [198.555432] Starting dynamic subtest: pipe-C-eDP-1 [200.084697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.543s) [200.085579] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.999s) [201.060519] [122/171] (798s left) kms_pipe_crc_basic (read-crc) [201.141595] Starting subtest: read-crc [201.142570] Starting dynamic subtest: pipe-A-eDP-1 [201.941332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s) [201.957842] Starting dynamic subtest: pipe-B-eDP-1 [203.459937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.517s) [203.467844] Starting dynamic subtest: pipe-C-eDP-1 [204.923008] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.463s) [204.923885] Subtest read-crc: SUCCESS (3.783s) [205.860921] [123/171] (793s left) kms_pipe_crc_basic (read-crc-frame-sequence) [205.946057] Starting subtest: read-crc-frame-sequence [205.948237] Starting dynamic subtest: pipe-A-eDP-1 [206.718931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s) [206.727452] Starting dynamic subtest: pipe-B-eDP-1 [208.231646] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.512s) [208.249246] Starting dynamic subtest: pipe-C-eDP-1 [209.713228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.479s) [209.714166] Subtest read-crc-frame-sequence: SUCCESS (3.767s) [210.659283] [124/171] (788s left) kms_psr (primary_page_flip) [210.739381] Starting subtest: primary_page_flip [212.704335] Subtest primary_page_flip: SUCCESS (1.964s) [213.667525] [125/171] (785s left) kms_psr (cursor_plane_move) [213.742943] Starting subtest: cursor_plane_move [215.673262] Subtest cursor_plane_move: SUCCESS (1.926s) [216.611207] [126/171] (782s left) kms_psr (sprite_plane_onoff) [216.693761] Starting subtest: sprite_plane_onoff [218.689965] Subtest sprite_plane_onoff: SUCCESS (1.995s) [219.619541] [127/171] (779s left) kms_psr (primary_mmap_gtt) [219.696542] Starting subtest: primary_mmap_gtt [221.663406] Subtest primary_mmap_gtt: SUCCESS (1.966s) [222.627446] [128/171] (776s left) kms_setmode (basic-clone-single-crtc) [222.680111] Starting subtest: basic-clone-single-crtc [222.682410] Subtest basic-clone-single-crtc: SKIP (0.000s) [222.758349] [129/171] (776s left) i915_pm_backlight (basic-brightness) [222.839470] Starting subtest: basic-brightness [222.921125] Starting dynamic subtest: eDP-1 [223.260388] Dynamic subtest eDP-1: SUCCESS (0.340s) [223.261693] Subtest basic-brightness: SUCCESS (0.419s) [224.229111] [130/171] (775s left) i915_pm_rpm (basic-pci-d3-state) [229.667044] Starting subtest: basic-pci-d3-state [234.258728] Subtest basic-pci-d3-state: SUCCESS (4.599s) [234.427501] [131/171] (764s left) i915_pm_rpm (basic-rte) [234.479232] Starting subtest: basic-rte [244.427113] Subtest basic-rte: SUCCESS (9.946s) [249.842122] [132/171] (749s left) i915_pm_rps (basic-api) [249.898638] Starting subtest: basic-api [249.900150] Subtest basic-api: SKIP (0.000s) [249.977453] [133/171] (749s left) prime_self_import (basic-llseek-bad) [250.028645] Starting subtest: basic-llseek-bad [250.030786] Subtest basic-llseek-bad: SUCCESS (0.001s) [250.127909] [134/171] (749s left) prime_self_import (basic-llseek-size) [250.174567] Starting subtest: basic-llseek-size [250.176628] Subtest basic-llseek-size: SUCCESS (0.002s) [250.262257] [135/171] (749s left) prime_self_import (basic-with_fd_dup) [250.308516] Starting subtest: basic-with_fd_dup [250.310623] Subtest basic-with_fd_dup: SUCCESS (0.002s) [250.394526] [136/171] (749s left) prime_self_import (basic-with_one_bo) [250.440841] Starting subtest: basic-with_one_bo [250.443013] Subtest basic-with_one_bo: SUCCESS (0.002s) [250.492515] [137/171] (748s left) prime_self_import (basic-with_one_bo_two_files) [250.544614] Starting subtest: basic-with_one_bo_two_files [250.546793] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [250.644419] [138/171] (748s left) prime_self_import (basic-with_two_bos) [250.691035] Starting subtest: basic-with_two_bos [250.693190] Subtest basic-with_two_bos: SUCCESS (0.002s) [250.778189] [139/171] (748s left) prime_vgem (basic-fence-flip) [250.836680] Starting subtest: basic-fence-flip [251.277121] Subtest basic-fence-flip: SUCCESS (0.440s) [251.390312] [140/171] (748s left) prime_vgem (basic-fence-mmap) [251.447493] Starting subtest: basic-fence-mmap [251.468255] Subtest basic-fence-mmap: SUCCESS (0.021s) [251.555594] [141/171] (748s left) prime_vgem (basic-fence-read) [251.613688] Starting subtest: basic-fence-read [251.621540] Subtest basic-fence-read: SKIP (0.007s) [251.704632] [142/171] (747s left) prime_vgem (basic-gtt) [251.773254] Starting subtest: basic-gtt [251.787932] Subtest basic-gtt: SUCCESS (0.015s) [251.887860] [143/171] (747s left) prime_vgem (basic-read) [251.948012] Starting subtest: basic-read [251.957888] Subtest basic-read: SKIP (0.009s) [252.055365] [144/171] (747s left) prime_vgem (basic-write) [252.122211] Starting subtest: basic-write [252.130173] Subtest basic-write: SKIP (0.007s) [252.220947] [145/171] (747s left) prime_vgem (basic-userptr) [252.280769] Starting subtest: basic-userptr [252.288791] Subtest basic-userptr: SKIP (0.007s) [252.371830] [146/171] (747s left) vgem_basic (setversion) [252.426366] Starting subtest: setversion [252.427871] Subtest setversion: SUCCESS (0.000s) [252.485110] [147/171] (747s left) vgem_basic (create) [252.543157] Starting subtest: create [252.544304] Subtest create: SUCCESS (0.000s) [252.606234] [148/171] (747s left) vgem_basic (debugfs) [252.660414] Starting subtest: debugfs [252.661267] Subtest debugfs: SUCCESS (0.000s) [252.722776] [149/171] (746s left) vgem_basic (dmabuf-export) [252.776518] Starting subtest: dmabuf-export [252.778781] Subtest dmabuf-export: SUCCESS (0.001s) [252.872553] [150/171] (746s left) vgem_basic (dmabuf-fence) [252.926478] Starting subtest: dmabuf-fence [252.927401] Subtest dmabuf-fence: SUCCESS (0.000s) [252.986199] [151/171] (746s left) vgem_basic (dmabuf-fence-before) [253.043137] Starting subtest: dmabuf-fence-before [253.044203] Subtest dmabuf-fence-before: SUCCESS (0.000s) [253.105515] [152/171] (746s left) vgem_basic (dmabuf-mmap) [253.159819] Starting subtest: dmabuf-mmap [253.173262] Subtest dmabuf-mmap: SUCCESS (0.013s) [253.212690] [153/171] (746s left) vgem_basic (mmap) [253.276501] Starting subtest: mmap [253.285033] Subtest mmap: SUCCESS (0.009s) [253.331894] [154/171] (746s left) vgem_basic (second-client) [253.393171] Starting subtest: second-client [253.444415] Subtest second-client: SUCCESS (0.050s) [253.506484] [155/171] (746s left) vgem_basic (sysfs) [253.559725] Starting subtest: sysfs [253.560506] Subtest sysfs: SUCCESS (0.000s) [253.617146] [156/171] (746s left) core_hotunplug (unbind-rebind) [253.693326] Starting subtest: unbind-rebind [255.847445] Subtest unbind-rebind: SUCCESS (2.154s) [255.863161] [157/171] (743s left) vgem_basic (unload) [255.911618] Starting subtest: unload [284.721045] Subtest unload: SUCCESS (28.775s) [284.808814] [158/171] (715s left) i915_module_load (reload) [284.861977] Starting subtest: reload [287.491177] Subtest reload: SUCCESS (2.629s) [287.504978] [159/171] (712s left) gem_lmem_swapping (basic) [287.560058] Subtest basic: SKIP (0.000s) [287.581711] [160/171] (712s left) gem_lmem_swapping (parallel-random-engines) [287.633067] Subtest parallel-random-engines: SKIP (0.000s) [287.669177] [161/171] (712s left) gem_lmem_swapping (random-engines) [287.729254] Subtest random-engines: SKIP (0.000s) [287.769667] [162/171] (712s left) gem_lmem_swapping (verify-random) [287.820124] Subtest verify-random: SKIP (0.000s) [287.849440] [163/171] (712s left) i915_pm_rpm (module-reload) [294.300187] Starting subtest: module-reload [313.917482] Subtest module-reload: SUCCESS (19.611s) [313.935545] [164/171] (685s left) i915_selftest (live) [313.995119] Starting subtest: live [313.996282] Starting dynamic subtest: sanitycheck [315.474418] Dynamic subtest sanitycheck: SUCCESS (1.470s) [315.480308] Starting dynamic subtest: uncore [316.945536] Dynamic subtest uncore: SUCCESS (1.471s) [316.951071] Starting dynamic subtest: workarounds [319.131407] Dynamic subtest workarounds: SUCCESS (2.185s) [319.136762] Starting dynamic subtest: gt_engines [321.090399] Dynamic subtest gt_engines: SUCCESS (1.959s) [321.097175] Starting dynamic subtest: gt_timelines [329.845320] Dynamic subtest gt_timelines: SUCCESS (8.755s) [329.850959] Starting dynamic subtest: gt_contexts [331.355346] Dynamic subtest gt_contexts: SUCCESS (1.510s) [331.360823] Starting dynamic subtest: gt_lrc [335.251247] Dynamic subtest gt_lrc: SUCCESS (3.896s) [335.256847] Starting dynamic subtest: gt_mocs [337.167235] Dynamic subtest gt_mocs: SUCCESS (1.915s) [337.172539] Starting dynamic subtest: gt_pm [339.548749] Dynamic subtest gt_pm: SUCCESS (2.381s) [339.554520] Starting dynamic subtest: gt_heartbeat [341.129365] Dynamic subtest gt_heartbeat: SUCCESS (1.580s) [341.135452] Starting dynamic subtest: requests [348.770712] Dynamic subtest requests: SUCCESS (7.641s) [348.777518] Starting dynamic subtest: migrate [353.106316] Dynamic subtest migrate: SUCCESS (4.335s) [353.111983] Starting dynamic subtest: active [354.584329] Dynamic subtest active: SUCCESS (1.478s) [354.589743] Starting dynamic subtest: objects [356.712311] Dynamic subtest objects: SUCCESS (2.127s) [356.717886] Starting dynamic subtest: mman [361.733492] Dynamic subtest mman: SUCCESS (5.021s) [361.739642] Starting dynamic subtest: dmabuf [363.301331] Dynamic subtest dmabuf: SUCCESS (1.567s) [363.306742] Starting dynamic subtest: vma [364.809259] Dynamic subtest vma: SUCCESS (1.508s) [364.814689] Starting dynamic subtest: coherency [369.077371] Dynamic subtest coherency: SUCCESS (4.268s) [369.083036] Starting dynamic subtest: gtt [379.507753] Dynamic subtest gtt: SUCCESS (10.430s) [379.514759] Starting dynamic subtest: gem [381.213414] Dynamic subtest gem: SUCCESS (1.705s) [381.219531] Starting dynamic subtest: evict [384.338369] Dynamic subtest evict: SUCCESS (3.125s) [384.343773] Starting dynamic subtest: hugepages [390.859028] Dynamic subtest hugepages: SUCCESS (6.520s) [390.866074] Starting dynamic subtest: gem_contexts [404.820933] Dynamic subtest gem_contexts: SUCCESS (13.961s) [404.828783] Starting dynamic subtest: client [406.350408] Dynamic subtest client: SUCCESS (1.529s) [406.356412] Starting dynamic subtest: gem_migrate [407.818401] Dynamic subtest gem_migrate: SUCCESS (1.468s) [407.824751] Starting dynamic subtest: reset [412.094640] Dynamic subtest reset: SUCCESS (4.276s) [412.100821] Starting dynamic subtest: memory_region [413.591408] Dynamic subtest memory_region: SUCCESS (1.496s) [413.597602] Starting dynamic subtest: hangcheck [429.562878] Dynamic subtest hangcheck: SUCCESS (15.971s) [429.570417] Starting dynamic subtest: execlists [431.071429] Dynamic subtest execlists: SUCCESS (1.508s) [431.077764] Starting dynamic subtest: ring_submission [432.560455] Dynamic subtest ring_submission: SUCCESS (1.489s) [432.566260] Starting dynamic subtest: perf [434.130478] Dynamic subtest perf: SUCCESS (1.570s) [434.136671] Starting dynamic subtest: slpc [440.457538] Dynamic subtest slpc: FAIL (6.278s) [440.462729] Starting dynamic subtest: guc [442.677400] Dynamic subtest guc: SUCCESS (2.267s) [442.683272] Starting dynamic subtest: guc_multi_lrc [444.168415] Dynamic subtest guc_multi_lrc: SUCCESS (1.491s) [444.174024] Starting dynamic subtest: guc_hang [446.225457] Dynamic subtest guc_hang: SUCCESS (2.056s) [446.231397] Starting dynamic subtest: late_gt_pm [447.683370] Dynamic subtest late_gt_pm: SUCCESS (1.458s) [447.684321] Subtest live: FAIL (133.679s) [447.753923] [165/171] (552s left) dmabuf (all-tests) [447.808239] Starting subtest: all-tests [447.809314] Starting dynamic subtest: sanitycheck [447.827568] Dynamic subtest sanitycheck: SUCCESS (0.019s) [447.837258] Starting dynamic subtest: dma_fence [447.959348] Dynamic subtest dma_fence: SUCCESS (0.131s) [447.966202] Starting dynamic subtest: dma_fence_chain [460.336426] Dynamic subtest dma_fence_chain: SUCCESS (12.377s) [460.350847] Starting dynamic subtest: dma_fence_unwrap [460.360768] Dynamic subtest dma_fence_unwrap: SUCCESS (0.024s) [460.383025] Starting dynamic subtest: dma_resv [460.387878] Dynamic subtest dma_resv: SUCCESS (0.026s) [460.389618] Subtest all-tests: SUCCESS (12.579s) [460.407752] [166/171] (539s left) i915_suspend (basic-s2idle-without-i915) [460.465983] Starting subtest: basic-s2idle-without-i915 [480.183400] Subtest basic-s2idle-without-i915: SUCCESS (4.005s) [480.544804] [167/171] (535s left) i915_suspend (basic-s3-without-i915) [480.595430] Starting subtest: basic-s3-without-i915 [499.193648] Subtest basic-s3-without-i915: SUCCESS (2.863s) [499.534649] [168/171] (531s left) gem_exec_suspend (basic-s0) [499.638625] Starting subtest: basic-S0 [499.639670] Starting dynamic subtest: smem [517.315266] Dynamic subtest smem: SUCCESS (3.015s) [517.316677] Subtest basic-S0: SUCCESS (3.015s) [517.473343] [169/171] (528s left) gem_exec_suspend (basic-s3) [517.531010] Starting subtest: basic-S3 [517.531799] Starting dynamic subtest: smem [535.330125] Dynamic subtest smem: SUCCESS (2.796s) [535.332047] Subtest basic-S3: SUCCESS (2.796s) [535.488351] [170/171] (525s left) kms_chamelium_hpd (common-hpd-after-suspend) [535.873337] Subtest common-hpd-after-suspend: SKIP (0.000s) [536.747456] [171/171] (524s left) kms_pipe_crc_basic (suspend-read-crc) [536.815277] Starting subtest: suspend-read-crc [536.816063] Starting dynamic subtest: pipe-A-eDP-1 [554.542010] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.456s) [554.563578] Starting dynamic subtest: pipe-B-eDP-1 [572.523458] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.160s) [572.541384] Starting dynamic subtest: pipe-C-eDP-1 [590.452055] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.072s) [590.452803] Subtest suspend-read-crc: SUCCESS (8.694s) [591.357323] Closing watchdogs Done.