[47.157633] Initializing watchdogs [47.157802] /dev/watchdog0 [47.168320] [001/171] (960s left) i915_module_load (load) [47.313702] Starting subtest: load [49.884320] Subtest load: SUCCESS (2.571s) [49.910822] [002/171] (957s left) core_auth (basic-auth) [50.046665] Starting subtest: basic-auth [50.049245] Subtest basic-auth: SUCCESS (0.002s) [50.138427] [003/171] (957s left) debugfs_test (read_all_entries) [50.287562] Starting subtest: read_all_entries [50.369662] Subtest read_all_entries: SUCCESS (0.081s) [50.482893] [004/171] (957s left) debugfs_test (basic-hwmon) [50.627211] Starting subtest: basic-hwmon [50.629292] Subtest basic-hwmon: SKIP (0.000s) [50.735079] [005/171] (957s left) fbdev (eof) [50.919836] Starting subtest: eof [50.921786] Subtest eof: SUCCESS (0.002s) [50.985157] [006/171] (956s left) fbdev (info) [51.139278] Starting subtest: info [51.140524] Subtest info: SUCCESS (0.000s) [51.220458] [007/171] (956s left) fbdev (nullptr) [51.368644] Starting subtest: nullptr [51.369795] Subtest nullptr: SUCCESS (0.000s) [51.433690] [008/171] (956s left) fbdev (read) [51.585196] Starting subtest: read [58.707975] Subtest read: SUCCESS (7.088s) [58.751781] [009/171] (949s left) fbdev (write) [58.902728] Starting subtest: write [62.665660] Subtest write: SUCCESS (3.738s) [62.725128] [010/171] (945s left) gem_basic (bad-close) [62.877682] Starting subtest: bad-close [62.879740] Subtest bad-close: SUCCESS (0.000s) [62.950493] [011/171] (944s left) gem_basic (create-close) [63.092341] Starting subtest: create-close [63.094368] Subtest create-close: SUCCESS (0.000s) [63.200539] [012/171] (944s left) gem_basic (create-fd-close) [63.337768] Starting subtest: create-fd-close [63.339897] Subtest create-fd-close: SUCCESS (0.000s) [63.433605] [013/171] (944s left) gem_busy (busy@all-engines) [63.583278] Starting subtest: busy [63.584492] Starting dynamic subtest: all-engines [63.640481] Dynamic subtest all-engines: SUCCESS (0.057s) [63.641594] Subtest busy: SUCCESS (0.058s) [64.018952] [014/171] (943s left) gem_close_race (basic-process) [64.170685] Starting subtest: basic-process [64.245478] Subtest basic-process: SUCCESS (0.074s) [64.451809] [015/171] (943s left) gem_close_race (basic-threads) [64.608595] Starting subtest: basic-threads [65.776664] Subtest basic-threads: SUCCESS (1.168s) [66.000253] [016/171] (942s left) gem_ctx_create (basic) [66.146127] Starting subtest: basic [66.147245] Subtest basic: SUCCESS (0.000s) [66.357412] [017/171] (941s left) gem_ctx_create (basic-files) [66.510532] Starting subtest: basic-files [68.534640] Subtest basic-files: SUCCESS (2.024s) [68.764033] [018/171] (939s left) gem_ctx_exec (basic) [68.898098] Starting subtest: basic [68.902482] Subtest basic: SUCCESS (0.004s) [69.018468] [019/171] (939s left) gem_exec_basic (basic) [69.172346] Starting subtest: basic [69.173469] Starting dynamic subtest: rcs0-smem [69.174498] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [69.186204] Starting dynamic subtest: bcs0-smem [69.187466] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [69.197606] Starting dynamic subtest: vcs0-smem [69.198758] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [69.208999] Starting dynamic subtest: vecs0-smem [69.210250] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [69.211383] Subtest basic: SUCCESS (0.006s) [69.384886] [020/171] (938s left) gem_exec_create (basic) [69.542999] Starting subtest: basic [69.544992] Starting dynamic subtest: smem [71.588637] Dynamic subtest smem: SUCCESS (2.046s) [71.589829] Subtest basic: SUCCESS (2.046s) [71.816305] [021/171] (936s left) gem_exec_fence (basic-busy) [72.131616] Starting subtest: basic-busy [72.133241] Starting dynamic subtest: rcs0 [72.159371] Dynamic subtest rcs0: SUCCESS (0.036s) [72.173967] Starting dynamic subtest: bcs0 [72.186174] Dynamic subtest bcs0: SUCCESS (0.027s) [72.199193] Starting dynamic subtest: vcs0 [72.203387] Dynamic subtest vcs0: SUCCESS (0.017s) [72.214541] Starting dynamic subtest: vecs0 [72.233045] Dynamic subtest vecs0: SUCCESS (0.029s) [72.234374] Subtest basic-busy: SUCCESS (0.110s) [72.837906] [022/171] (935s left) gem_exec_fence (basic-wait) [73.117532] Starting subtest: basic-wait [73.118879] Starting dynamic subtest: rcs0 [73.143426] Dynamic subtest rcs0: SUCCESS (0.026s) [73.159086] Starting dynamic subtest: bcs0 [73.173958] Dynamic subtest bcs0: SUCCESS (0.028s) [73.190644] Starting dynamic subtest: vcs0 [73.202856] Dynamic subtest vcs0: SUCCESS (0.029s) [73.222820] Starting dynamic subtest: vecs0 [73.228683] Dynamic subtest vecs0: SUCCESS (0.027s) [73.229890] Subtest basic-wait: SUCCESS (0.111s) [73.788116] [023/171] (934s left) gem_exec_fence (basic-await) [74.082821] Starting subtest: basic-await [74.084098] Starting dynamic subtest: rcs0 [74.175738] Dynamic subtest rcs0: SUCCESS (0.101s) [74.189960] Starting dynamic subtest: bcs0 [74.276680] Dynamic subtest bcs0: SUCCESS (0.099s) [74.290105] Starting dynamic subtest: vcs0 [74.372937] Dynamic subtest vcs0: SUCCESS (0.095s) [74.386741] Starting dynamic subtest: vecs0 [74.467324] Dynamic subtest vecs0: SUCCESS (0.096s) [74.469236] Subtest basic-await: SUCCESS (0.393s) [75.086327] [024/171] (933s left) gem_exec_fence (nb-await) [75.386808] Starting subtest: nb-await [75.387991] Starting dynamic subtest: rcs0 [75.444886] Dynamic subtest rcs0: SUCCESS (0.065s) [75.463790] Starting dynamic subtest: bcs0 [75.514913] Dynamic subtest bcs0: SUCCESS (0.069s) [75.542224] Starting dynamic subtest: vcs0 [75.591993] Dynamic subtest vcs0: SUCCESS (0.076s) [75.619920] Starting dynamic subtest: vecs0 [75.666199] Dynamic subtest vecs0: SUCCESS (0.074s) [75.668348] Subtest nb-await: SUCCESS (0.287s) [76.220050] [025/171] (932s left) gem_exec_gttfill (basic) [76.366885] Starting subtest: basic [82.267443] Subtest basic: SUCCESS (5.892s) [82.458697] [026/171] (925s left) gem_exec_parallel (engines) [82.673181] Starting subtest: engines [82.674323] Starting dynamic subtest: basic [85.146257] Dynamic subtest basic: SUCCESS (2.451s) [85.161593] Starting dynamic subtest: contexts [88.428652] Dynamic subtest contexts: SUCCESS (3.294s) [88.442641] Starting dynamic subtest: fds [93.171124] Dynamic subtest fds: SUCCESS (4.741s) [93.200397] Starting dynamic subtest: userptr [95.749557] Dynamic subtest userptr: SUCCESS (2.566s) [95.751200] Subtest engines: SUCCESS (13.054s) [95.952063] [027/171] (912s left) gem_exec_store (basic) [96.099374] Starting subtest: basic [96.162747] Subtest basic: SUCCESS (0.063s) [96.373340] [028/171] (912s left) gem_flink_basic (bad-flink) [96.510871] Starting subtest: bad-flink [96.512171] Subtest bad-flink: SUCCESS (0.000s) [96.587504] [029/171] (911s left) gem_flink_basic (bad-open) [96.726446] Starting subtest: bad-open [96.727537] Subtest bad-open: SUCCESS (0.000s) [96.804835] [030/171] (911s left) gem_flink_basic (basic) [96.943388] Starting subtest: basic [96.944577] Subtest basic: SUCCESS (0.000s) [97.038107] [031/171] (911s left) gem_flink_basic (double-flink) [97.176449] Starting subtest: double-flink [97.177559] Subtest double-flink: SUCCESS (0.000s) [97.287513] [032/171] (911s left) gem_flink_basic (flink-lifetime) [97.428176] Starting subtest: flink-lifetime [97.430622] Subtest flink-lifetime: SUCCESS (0.002s) [97.537429] [033/171] (910s left) gem_huc_copy (huc-copy) [97.679742] Starting subtest: huc-copy [97.681957] Subtest huc-copy: SKIP (0.000s) [97.787387] [034/171] (910s left) gem_linear_blits (basic) [98.082467] Starting subtest: basic [98.094366] Subtest basic: SUCCESS (0.012s) [98.223840] [035/171] (910s left) gem_mmap (basic) [98.426044] Starting subtest: basic [98.432176] Subtest basic: SUCCESS (0.001s) [98.538275] [036/171] (910s left) gem_mmap_gtt (basic) [98.669556] Starting subtest: basic [98.670740] Subtest basic: SUCCESS (0.001s) [98.752944] [037/171] (909s left) gem_render_linear_blits (basic) [98.894210] Starting subtest: basic [98.946579] Subtest basic: SUCCESS (0.051s) [99.003324] [038/171] (909s left) gem_render_tiled_blits (basic) [99.141347] Starting subtest: basic [99.201695] Subtest basic: SUCCESS (0.060s) [99.273688] [039/171] (909s left) gem_ringfill (basic-all) [99.535695] Starting subtest: basic-all [100.754616] Subtest basic-all: SUCCESS (1.211s) [100.874380] [040/171] (907s left) gem_softpin (allocator-basic) [101.009771] Starting subtest: allocator-basic [101.182164] Subtest allocator-basic: SUCCESS (0.163s) [101.289216] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [101.443498] Starting subtest: allocator-basic-reserve [101.620680] Subtest allocator-basic-reserve: SUCCESS (0.167s) [101.723850] [042/171] (907s left) gem_softpin (safe-alignment) [101.883875] Starting subtest: safe-alignment [101.902384] Subtest safe-alignment: SUCCESS (0.018s) [102.021174] [043/171] (906s left) gem_sync (basic-all) [102.170626] Starting subtest: basic-all [104.422349] Subtest basic-all: SUCCESS (2.229s) [104.605809] [044/171] (904s left) gem_sync (basic-each) [104.757273] Starting subtest: basic-each [107.124569] Subtest basic-each: SUCCESS (2.367s) [107.352264] [045/171] (901s left) gem_tiled_blits (basic) [107.656791] Starting subtest: basic [107.684655] Subtest basic: SUCCESS (0.028s) [107.823030] [046/171] (901s left) gem_tiled_fence_blits (basic) [108.187907] Starting subtest: basic [108.215253] Subtest basic: SUCCESS (0.028s) [108.335965] [047/171] (900s left) gem_tiled_pread_basic [108.874885] [048/171] (900s left) gem_wait (busy@all-engines) [109.031602] Starting subtest: busy [109.032841] Starting dynamic subtest: all-engines [109.569741] Dynamic subtest all-engines: SUCCESS (0.538s) [109.570945] Subtest busy: SUCCESS (0.538s) [109.823853] [049/171] (899s left) gem_wait (wait@all-engines) [109.986585] Starting subtest: wait [109.987768] Starting dynamic subtest: all-engines [111.025230] Dynamic subtest all-engines: SUCCESS (1.039s) [111.026346] Subtest wait: SUCCESS (1.039s) [111.273947] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [111.410608] Starting subtest: basic-eu-total [111.412832] Subtest basic-eu-total: SUCCESS (0.000s) [111.487820] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [111.627496] Starting subtest: basic-subslice-total [111.629804] Subtest basic-subslice-total: SUCCESS (0.000s) [111.704329] [052/171] (897s left) i915_hangman (error-state-basic) [111.848938] Starting subtest: error-state-basic [111.862309] Subtest error-state-basic: SUCCESS (0.013s) [111.955169] [053/171] (897s left) i915_pciid [112.171585] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [112.304545] Starting subtest: addfb25-bad-modifier [112.305691] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [112.437082] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [112.577442] Starting subtest: addfb25-framebuffer-vs-set-tiling [112.578564] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [112.704490] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [112.844478] Starting subtest: addfb25-modifier-no-flag [112.845521] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [112.989874] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [113.131914] Starting subtest: addfb25-x-tiled-legacy [113.132974] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [113.254459] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [113.394912] Starting subtest: addfb25-x-tiled-mismatch-legacy [113.396098] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [113.520385] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [113.690433] Starting subtest: addfb25-yf-tiled-legacy [113.691515] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [113.787298] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [113.957275] Starting subtest: addfb25-y-tiled-legacy [113.958620] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [114.054158] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [114.224248] Starting subtest: addfb25-y-tiled-small-legacy [114.225386] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [114.320838] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [114.462365] Starting subtest: bad-pitch-0 [114.463392] Subtest bad-pitch-0: SUCCESS (0.000s) [114.588169] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [114.728261] Starting subtest: bad-pitch-1024 [114.729546] Subtest bad-pitch-1024: SUCCESS (0.000s) [114.874591] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [115.018095] Starting subtest: bad-pitch-128 [115.019156] Subtest bad-pitch-128: SUCCESS (0.000s) [115.137266] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [115.277808] Starting subtest: bad-pitch-256 [115.279224] Subtest bad-pitch-256: SUCCESS (0.000s) [115.404317] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [115.541708] Starting subtest: bad-pitch-32 [115.542923] Subtest bad-pitch-32: SUCCESS (0.000s) [115.670594] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [115.808976] Starting subtest: bad-pitch-63 [115.810150] Subtest bad-pitch-63: SUCCESS (0.000s) [115.937784] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [116.076950] Starting subtest: bad-pitch-65536 [116.078147] Subtest bad-pitch-65536: SUCCESS (0.000s) [116.204335] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [116.343507] Starting subtest: bad-pitch-999 [116.344840] Subtest bad-pitch-999: SUCCESS (0.000s) [116.471175] [070/171] (893s left) kms_addfb_basic (basic) [116.608533] Starting subtest: basic [116.609848] Subtest basic: SUCCESS (0.000s) [116.738229] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [116.877682] Starting subtest: basic-x-tiled-legacy [116.878731] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [117.004160] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [117.144235] Starting subtest: basic-y-tiled-legacy [117.145295] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.270773] [073/171] (892s left) kms_addfb_basic (bo-too-small) [117.439080] Starting subtest: bo-too-small [117.440205] Subtest bo-too-small: SUCCESS (0.000s) [117.538351] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.705149] Starting subtest: bo-too-small-due-to-tiling [117.706286] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [117.805081] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [117.943807] Starting subtest: clobberred-modifier [117.945062] Subtest clobberred-modifier: SUCCESS (0.000s) [118.071146] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.209827] Starting subtest: framebuffer-vs-set-tiling [118.211057] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.337599] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [118.466570] Starting subtest: invalid-get-prop [118.467704] Subtest invalid-get-prop: SUCCESS (0.000s) [118.587185] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [118.726076] Starting subtest: invalid-get-prop-any [118.727161] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.837616] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [118.975726] Starting subtest: invalid-set-prop [118.976860] Subtest invalid-set-prop: SUCCESS (0.000s) [119.104339] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [119.241350] Starting subtest: invalid-set-prop-any [119.242435] Subtest invalid-set-prop-any: SUCCESS (0.000s) [119.370977] [081/171] (890s left) kms_addfb_basic (no-handle) [119.509881] Starting subtest: no-handle [119.510961] Subtest no-handle: SUCCESS (0.000s) [119.639060] [082/171] (890s left) kms_addfb_basic (size-max) [119.806347] Starting subtest: size-max [119.807424] Subtest size-max: SUCCESS (0.000s) [119.905193] [083/171] (890s left) kms_addfb_basic (small-bo) [120.072231] Starting subtest: small-bo [120.073328] Subtest small-bo: SUCCESS (0.000s) [120.170878] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [120.309187] Starting subtest: tile-pitch-mismatch [120.310253] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [120.437804] [085/171] (889s left) kms_addfb_basic (too-high) [120.604923] Starting subtest: too-high [120.606186] Subtest too-high: SUCCESS (0.001s) [120.703807] [086/171] (889s left) kms_addfb_basic (too-wide) [120.870407] Starting subtest: too-wide [120.871622] Subtest too-wide: SUCCESS (0.000s) [120.970847] [087/171] (889s left) kms_addfb_basic (unused-handle) [121.107475] Starting subtest: unused-handle [121.108553] Subtest unused-handle: SUCCESS (0.000s) [121.237321] [088/171] (888s left) kms_addfb_basic (unused-modifier) [121.375468] Starting subtest: unused-modifier [121.376540] Subtest unused-modifier: SUCCESS (0.000s) [121.487176] [089/171] (888s left) kms_addfb_basic (unused-offsets) [121.625383] Starting subtest: unused-offsets [121.626483] Subtest unused-offsets: SUCCESS (0.000s) [121.754477] [090/171] (888s left) kms_addfb_basic (unused-pitches) [121.892388] Starting subtest: unused-pitches [121.893477] Subtest unused-pitches: SUCCESS (0.000s) [122.021237] [091/171] (888s left) kms_busy (basic) [122.185338] Starting subtest: basic [122.188210] Starting dynamic subtest: flip [123.262290] Dynamic subtest flip: SUCCESS (1.069s) [123.279249] Starting dynamic subtest: modeset [127.145852] Dynamic subtest modeset: SUCCESS (3.888s) [127.152097] Subtest basic: SUCCESS (4.960s) [128.119460] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [128.602500] Subtest dp-hpd-fast: SKIP (0.000s) [129.475910] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [129.956454] Subtest dp-edid-read: SKIP (0.000s) [130.816557] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [131.297448] Subtest dp-crc-fast: SKIP (0.000s) [132.162605] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [132.644526] Subtest hdmi-hpd-fast: SKIP (0.000s) [133.505672] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [133.988748] Subtest hdmi-edid-read: SKIP (0.000s) [134.849859] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [135.330559] Subtest hdmi-crc-fast: SKIP (0.000s) [136.195029] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [136.675464] Subtest vga-hpd-fast: SKIP (0.000s) [137.537759] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [138.019579] Subtest vga-edid-read: SKIP (0.000s) [138.882913] [100/171] (871s left) kms_prop_blob (basic) [139.023578] Starting subtest: basic [139.024687] Subtest basic: SUCCESS (0.000s) [139.104318] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [139.262774] Starting subtest: basic-busy-flip-before-cursor-atomic [139.264900] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [139.347357] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [139.514949] Starting subtest: basic-busy-flip-before-cursor-legacy [139.517055] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [139.598068] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [139.765698] Starting subtest: basic-flip-after-cursor-atomic [141.047759] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.282s) [142.004228] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [142.172469] Starting subtest: basic-flip-after-cursor-legacy [143.462555] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.289s) [144.436427] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [144.604431] Starting subtest: basic-flip-after-cursor-varying-size [145.897388] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.293s) [146.868196] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [147.034415] Starting subtest: basic-flip-before-cursor-atomic [148.310196] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.275s) [149.236443] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [149.403358] Starting subtest: basic-flip-before-cursor-legacy [150.680465] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.277s) [151.605533] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [151.768537] Starting subtest: basic-flip-before-cursor-varying-size [153.032835] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.264s) [153.973693] [109/171] (856s left) kms_flip (basic-flip-vs-dpms) [154.113120] Starting subtest: basic-flip-vs-dpms [154.116423] Starting dynamic subtest: A-eDP1 [156.990243] Dynamic subtest A-eDP1: SUCCESS (2.874s) [157.016513] Starting dynamic subtest: B-eDP1 [159.327981] Dynamic subtest B-eDP1: SUCCESS (2.336s) [159.348240] Starting dynamic subtest: C-eDP1 [161.715184] Dynamic subtest C-eDP1: SUCCESS (2.386s) [161.717629] Subtest basic-flip-vs-dpms: SUCCESS (7.605s) [162.621401] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [162.773969] Starting subtest: basic-flip-vs-modeset [162.776996] Starting dynamic subtest: A-eDP1 [165.606999] Dynamic subtest A-eDP1: SUCCESS (2.830s) [165.625772] Starting dynamic subtest: B-eDP1 [167.966505] Dynamic subtest B-eDP1: SUCCESS (2.353s) [167.981641] Starting dynamic subtest: C-eDP1 [170.337828] Dynamic subtest C-eDP1: SUCCESS (2.373s) [170.338967] Subtest basic-flip-vs-modeset: SUCCESS (7.566s) [171.261497] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [171.407498] Starting subtest: basic-flip-vs-wf_vblank [171.411566] Starting dynamic subtest: A-eDP1 [173.716104] Dynamic subtest A-eDP1: SUCCESS (2.304s) [173.732978] Starting dynamic subtest: B-eDP1 [176.004648] Dynamic subtest B-eDP1: SUCCESS (2.287s) [176.024996] Starting dynamic subtest: C-eDP1 [178.246752] Dynamic subtest C-eDP1: SUCCESS (2.241s) [178.250843] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.842s) [179.574834] [112/171] (831s left) kms_flip (basic-plain-flip) [179.720681] Starting subtest: basic-plain-flip [179.724831] Starting dynamic subtest: A-eDP1 [181.753782] Dynamic subtest A-eDP1: SUCCESS (2.029s) [181.777083] Starting dynamic subtest: B-eDP1 [183.721691] Dynamic subtest B-eDP1: SUCCESS (1.967s) [183.740442] Starting dynamic subtest: C-eDP1 [185.702386] Dynamic subtest C-eDP1: SUCCESS (1.979s) [185.705315] Subtest basic-plain-flip: SUCCESS (5.985s) [186.996754] [113/171] (823s left) kms_force_connector_basic (force-connector-state) [187.133957] Starting subtest: force-connector-state [188.862837] Subtest force-connector-state: SUCCESS (1.729s) [189.475655] [114/171] (821s left) kms_force_connector_basic (force-edid) [189.618631] Starting subtest: force-edid [189.873994] Subtest force-edid: SUCCESS (0.251s) [190.008063] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [190.150618] Starting subtest: force-load-detect [190.152814] Subtest force-load-detect: SKIP (0.000s) [190.275197] [116/171] (820s left) kms_force_connector_basic (prune-stale-modes) [190.419047] Starting subtest: prune-stale-modes [190.728128] Subtest prune-stale-modes: SUCCESS (0.305s) [190.857637] [117/171] (820s left) kms_frontbuffer_tracking (basic) [191.031176] Starting subtest: basic [194.282410] Subtest basic: SUCCESS (3.241s) [194.409323] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [194.574953] Starting subtest: compare-crc-sanitycheck-xr24 [194.577701] Starting dynamic subtest: pipe-A-eDP-1 [195.251552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s) [195.281678] Starting dynamic subtest: pipe-B-eDP-1 [196.654449] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s) [196.672469] Starting dynamic subtest: pipe-C-eDP-1 [198.204493] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.548s) [198.205761] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.620s) [199.151376] [119/171] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [199.322424] Starting subtest: compare-crc-sanitycheck-nv12 [199.325442] Starting dynamic subtest: pipe-A-eDP-1 [200.244613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s) [200.269221] Starting dynamic subtest: pipe-B-eDP-1 [201.714950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s) [201.731553] Starting dynamic subtest: pipe-C-eDP-1 [203.489263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.779s) [203.493388] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.167s) [204.401608] [120/171] (806s left) kms_pipe_crc_basic (hang-read-crc) [204.571171] Starting subtest: hang-read-crc [204.574346] Starting dynamic subtest: pipe-A-eDP-1 [206.879235] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.306s) [206.898520] Starting dynamic subtest: pipe-B-eDP-1 [209.854807] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s) [209.874194] Starting dynamic subtest: pipe-C-eDP-1 [213.176864] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.317s) [213.178165] Subtest hang-read-crc: SUCCESS (8.605s) [214.128782] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc) [214.301700] Starting subtest: nonblocking-crc [214.303151] Starting dynamic subtest: pipe-A-eDP-1 [215.151794] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s) [215.171229] Starting dynamic subtest: pipe-B-eDP-1 [216.706406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [216.727270] Starting dynamic subtest: pipe-C-eDP-1 [218.429808] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.721s) [218.431086] Subtest nonblocking-crc: SUCCESS (4.129s) [219.375813] [122/171] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [219.550066] Starting subtest: nonblocking-crc-frame-sequence [219.553328] Starting dynamic subtest: pipe-A-eDP-1 [220.400367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s) [220.419491] Starting dynamic subtest: pipe-B-eDP-1 [221.955206] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.552s) [221.974984] Starting dynamic subtest: pipe-C-eDP-1 [223.684470] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.724s) [223.685575] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.135s) [224.624711] [123/171] (786s left) kms_pipe_crc_basic (read-crc) [224.794515] Starting subtest: read-crc [224.797558] Starting dynamic subtest: pipe-A-eDP-1 [225.581439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [225.600831] Starting dynamic subtest: pipe-B-eDP-1 [227.069347] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [227.089893] Starting dynamic subtest: pipe-C-eDP-1 [228.723256] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [228.724370] Subtest read-crc: SUCCESS (3.926s) [229.680508] [124/171] (781s left) kms_pipe_crc_basic (read-crc-frame-sequence) [229.849826] Starting subtest: read-crc-frame-sequence [229.850937] Starting dynamic subtest: pipe-A-eDP-1 [230.639121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s) [230.658647] Starting dynamic subtest: pipe-B-eDP-1 [232.126513] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [232.144558] Starting dynamic subtest: pipe-C-eDP-1 [233.786740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.657s) [233.788029] Subtest read-crc-frame-sequence: SUCCESS (3.939s) [234.736561] [125/171] (776s left) kms_psr (primary_page_flip) [234.910240] Starting subtest: primary_page_flip [239.188931] Subtest primary_page_flip: SUCCESS (4.268s) [240.113033] [126/171] (771s left) kms_psr (cursor_plane_move) [240.284786] Starting subtest: cursor_plane_move [244.477981] Subtest cursor_plane_move: SUCCESS (4.194s) [245.406782] [127/171] (765s left) kms_psr (sprite_plane_onoff) [245.580276] Starting subtest: sprite_plane_onoff [249.872195] Subtest sprite_plane_onoff: SUCCESS (4.292s) [250.800880] [128/171] (760s left) kms_psr (primary_mmap_gtt) [250.978451] Starting subtest: primary_mmap_gtt [255.201252] Subtest primary_mmap_gtt: SUCCESS (4.221s) [256.112064] [129/171] (755s left) kms_setmode (basic-clone-single-crtc) [256.256749] Starting subtest: basic-clone-single-crtc [256.260251] Subtest basic-clone-single-crtc: SKIP (0.000s) [256.344909] [130/171] (754s left) i915_pm_backlight (basic-brightness) [256.516579] Starting subtest: basic-brightness [256.634905] Starting dynamic subtest: eDP-1 [257.187702] Dynamic subtest eDP-1: SUCCESS (0.562s) [257.188887] Subtest basic-brightness: SUCCESS (0.674s) [258.096829] [131/171] (753s left) i915_pm_rpm (basic-pci-d3-state) [259.984462] Starting subtest: basic-pci-d3-state [264.393619] Subtest basic-pci-d3-state: SUCCESS (4.409s) [264.597474] [132/171] (746s left) i915_pm_rpm (basic-rte) [264.737454] Starting subtest: basic-rte [270.863280] Subtest basic-rte: SUCCESS (6.119s) [276.172524] [133/171] (735s left) i915_pm_rps (basic-api) [276.323534] Starting subtest: basic-api [276.327874] Subtest basic-api: SUCCESS (0.004s) [276.422713] [134/171] (735s left) prime_self_import (basic-llseek-bad) [276.550645] Starting subtest: basic-llseek-bad [276.554958] Subtest basic-llseek-bad: SUCCESS (0.003s) [276.653512] [135/171] (734s left) prime_self_import (basic-llseek-size) [276.790542] Starting subtest: basic-llseek-size [276.795098] Subtest basic-llseek-size: SUCCESS (0.004s) [276.886839] [136/171] (734s left) prime_self_import (basic-with_fd_dup) [277.024028] Starting subtest: basic-with_fd_dup [277.028630] Subtest basic-with_fd_dup: SUCCESS (0.005s) [277.137049] [137/171] (734s left) prime_self_import (basic-with_one_bo) [277.274749] Starting subtest: basic-with_one_bo [277.280186] Subtest basic-with_one_bo: SUCCESS (0.005s) [277.368244] [138/171] (734s left) prime_self_import (basic-with_one_bo_two_files) [277.505191] Starting subtest: basic-with_one_bo_two_files [277.509722] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [277.620128] [139/171] (733s left) prime_self_import (basic-with_two_bos) [277.757221] Starting subtest: basic-with_two_bos [277.761995] Subtest basic-with_two_bos: SUCCESS (0.005s) [277.861618] [140/171] (733s left) prime_vgem (basic-fence-flip) [278.009125] Starting subtest: basic-fence-flip [278.534329] Subtest basic-fence-flip: SUCCESS (0.524s) [278.658847] [141/171] (732s left) prime_vgem (basic-fence-mmap) [278.809138] Starting subtest: basic-fence-mmap [278.855423] Subtest basic-fence-mmap: SUCCESS (0.048s) [278.960165] [142/171] (732s left) prime_vgem (basic-fence-read) [279.124142] Starting subtest: basic-fence-read [279.199412] Subtest basic-fence-read: SUCCESS (0.075s) [279.293718] [143/171] (732s left) prime_vgem (basic-gtt) [279.462876] Starting subtest: basic-gtt [279.486529] Subtest basic-gtt: SUCCESS (0.023s) [279.590893] [144/171] (732s left) prime_vgem (basic-read) [279.742204] Starting subtest: basic-read [279.776661] Subtest basic-read: SUCCESS (0.036s) [279.890414] [145/171] (731s left) prime_vgem (basic-write) [280.040211] Starting subtest: basic-write [280.082838] Subtest basic-write: SUCCESS (0.042s) [280.173624] [146/171] (731s left) vgem_basic (setversion) [280.316174] Starting subtest: setversion [280.318399] Subtest setversion: SUCCESS (0.000s) [280.392461] [147/171] (731s left) vgem_basic (create) [280.532379] Starting subtest: create [280.533524] Subtest create: SUCCESS (0.000s) [280.609178] [148/171] (731s left) vgem_basic (debugfs) [280.749363] Starting subtest: debugfs [280.750452] Subtest debugfs: SUCCESS (0.001s) [280.822928] [149/171] (731s left) vgem_basic (dmabuf-export) [280.965845] Starting subtest: dmabuf-export [280.970627] Subtest dmabuf-export: SUCCESS (0.003s) [281.081048] [150/171] (730s left) vgem_basic (dmabuf-fence) [281.235745] Starting subtest: dmabuf-fence [281.236986] Subtest dmabuf-fence: SUCCESS (0.001s) [281.304861] [151/171] (730s left) vgem_basic (dmabuf-fence-before) [281.452450] Starting subtest: dmabuf-fence-before [281.453599] Subtest dmabuf-fence-before: SUCCESS (0.001s) [281.521523] [152/171] (730s left) vgem_basic (dmabuf-mmap) [281.668375] Starting subtest: dmabuf-mmap [281.693147] Subtest dmabuf-mmap: SUCCESS (0.026s) [281.771491] [153/171] (730s left) vgem_basic (mmap) [281.918280] Starting subtest: mmap [281.933781] Subtest mmap: SUCCESS (0.017s) [282.004472] [154/171] (730s left) vgem_basic (second-client) [282.151373] Starting subtest: second-client [282.185281] Subtest second-client: SUCCESS (0.033s) [282.255350] [155/171] (729s left) vgem_basic (sysfs) [282.401873] Starting subtest: sysfs [282.403077] Subtest sysfs: SUCCESS (0.001s) [282.471329] [156/171] (729s left) core_hotunplug (unbind-rebind) [282.650392] Starting subtest: unbind-rebind [285.148109] Subtest unbind-rebind: SUCCESS (2.494s) [285.182433] [157/171] (726s left) vgem_basic (unload) [285.321554] Starting subtest: unload [314.328542] Subtest unload: SUCCESS (28.996s) [314.469133] [158/171] (697s left) i915_module_load (reload) [314.608395] Starting subtest: reload [318.198181] Subtest reload: SUCCESS (3.589s) [318.229959] [159/171] (693s left) gem_lmem_swapping (basic) [318.389269] Subtest basic: SKIP (0.000s) [318.432132] [160/171] (693s left) gem_lmem_swapping (parallel-random-engines) [318.579347] Subtest parallel-random-engines: SKIP (0.000s) [318.635714] [161/171] (693s left) gem_lmem_swapping (random-engines) [318.799499] Subtest random-engines: SKIP (0.000s) [318.848792] [162/171] (693s left) gem_lmem_swapping (verify-random) [318.995257] Subtest verify-random: SKIP (0.000s) [319.051928] [163/171] (693s left) i915_pm_rpm (module-reload) [331.546893] Starting subtest: module-reload [366.421670] Subtest module-reload: SUCCESS (34.867s) [366.449087] [164/171] (645s left) i915_selftest (live) [366.597113] Starting subtest: live [366.598522] Starting dynamic subtest: sanitycheck [368.476515] Dynamic subtest sanitycheck: SUCCESS (1.870s) [368.490710] Starting dynamic subtest: uncore [370.342110] Dynamic subtest uncore: SUCCESS (1.861s) [370.359958] Starting dynamic subtest: workarounds [372.464550] Dynamic subtest workarounds: SUCCESS (2.119s) [372.478948] Starting dynamic subtest: gt_engines [374.754029] Dynamic subtest gt_engines: SUCCESS (2.286s) [374.768762] Starting dynamic subtest: gt_timelines [387.547050] Dynamic subtest gt_timelines: SUCCESS (12.790s) [387.561675] Starting dynamic subtest: gt_contexts [389.544175] Dynamic subtest gt_contexts: SUCCESS (1.994s) [389.558854] Starting dynamic subtest: gt_lrc [393.968628] Dynamic subtest gt_lrc: SUCCESS (4.421s) [393.983860] Starting dynamic subtest: gt_mocs [395.882444] Dynamic subtest gt_mocs: SUCCESS (1.910s) [395.896849] Starting dynamic subtest: gt_pm [400.996511] Dynamic subtest gt_pm: SUCCESS (5.110s) [401.011358] Starting dynamic subtest: gt_heartbeat [402.902699] Dynamic subtest gt_heartbeat: SUCCESS (1.903s) [402.917435] Starting dynamic subtest: gt_tlb [406.072803] Dynamic subtest gt_tlb: SUCCESS (3.167s) [406.087251] Starting dynamic subtest: requests [413.699968] Dynamic subtest requests: SUCCESS (7.623s) [413.714478] Starting dynamic subtest: migrate [418.311361] Dynamic subtest migrate: SUCCESS (4.608s) [418.326093] Starting dynamic subtest: active [420.128558] Dynamic subtest active: SUCCESS (1.814s) [420.142953] Starting dynamic subtest: objects [423.514550] Dynamic subtest objects: SUCCESS (3.382s) [423.529219] Starting dynamic subtest: mman [430.508548] Dynamic subtest mman: SUCCESS (6.991s) [430.523133] Starting dynamic subtest: dmabuf [432.364987] Dynamic subtest dmabuf: SUCCESS (1.852s) [432.379669] Starting dynamic subtest: vma [434.205131] Dynamic subtest vma: SUCCESS (1.837s) [434.219997] Starting dynamic subtest: coherency [438.758185] Dynamic subtest coherency: SUCCESS (4.550s) [438.773160] Starting dynamic subtest: gtt [448.277419] Dynamic subtest gtt: SUCCESS (9.516s) [448.292418] Starting dynamic subtest: gem [450.219521] Dynamic subtest gem: SUCCESS (1.939s) [450.234306] Starting dynamic subtest: evict [454.165375] Dynamic subtest evict: SUCCESS (3.943s) [454.180159] Starting dynamic subtest: hugepages [461.948613] Dynamic subtest hugepages: SUCCESS (7.780s) [461.963711] Starting dynamic subtest: gem_contexts [477.487760] Dynamic subtest gem_contexts: SUCCESS (15.535s) [477.503064] Starting dynamic subtest: client [479.323948] Dynamic subtest client: SUCCESS (1.840s) [479.338535] Starting dynamic subtest: gem_migrate [481.180465] Dynamic subtest gem_migrate: SUCCESS (1.847s) [481.195721] Starting dynamic subtest: reset [486.587600] Dynamic subtest reset: SUCCESS (5.404s) [486.602991] Starting dynamic subtest: memory_region [488.478613] Dynamic subtest memory_region: SUCCESS (1.888s) [488.493548] Starting dynamic subtest: hangcheck [512.894670] Dynamic subtest hangcheck: SUCCESS (24.413s) [512.910133] Starting dynamic subtest: execlists [523.076725] Dynamic subtest execlists: SUCCESS (10.179s) [523.091698] Starting dynamic subtest: ring_submission [524.959278] Dynamic subtest ring_submission: SUCCESS (1.879s) [524.975066] Starting dynamic subtest: perf [526.898316] Dynamic subtest perf: SUCCESS (1.936s) [526.913834] Starting dynamic subtest: slpc [528.730540] Dynamic subtest slpc: SUCCESS (1.829s) [528.745885] Starting dynamic subtest: guc [530.591411] Dynamic subtest guc: SUCCESS (1.857s) [530.606849] Starting dynamic subtest: guc_multi_lrc [532.438134] Dynamic subtest guc_multi_lrc: SUCCESS (1.844s) [532.453537] Starting dynamic subtest: guc_hang [534.309596] Dynamic subtest guc_hang: SUCCESS (1.868s) [534.325356] Starting dynamic subtest: late_gt_pm [536.161454] Dynamic subtest late_gt_pm: SUCCESS (1.849s) [536.162606] Subtest live: SUCCESS (169.557s) [536.350030] [165/171] (476s left) dmabuf (all-tests) [536.495300] Starting subtest: all-tests [536.496420] Starting dynamic subtest: sanitycheck [536.564726] Dynamic subtest sanitycheck: SUCCESS (0.071s) [536.584150] Starting dynamic subtest: dma_fence [536.749880] Dynamic subtest dma_fence: SUCCESS (0.181s) [536.769377] Starting dynamic subtest: dma_fence_chain [554.712191] Dynamic subtest dma_fence_chain: SUCCESS (17.950s) [554.726099] Starting dynamic subtest: dma_fence_unwrap [554.781666] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s) [554.801235] Starting dynamic subtest: dma_resv [554.863711] Dynamic subtest dma_resv: SUCCESS (0.078s) [554.865983] Subtest all-tests: SUCCESS (18.372s) [554.898997] [166/171] (457s left) i915_suspend (basic-s2idle-without-i915) [555.026512] Starting subtest: basic-s2idle-without-i915 [578.861622] Subtest basic-s2idle-without-i915: SUCCESS (8.421s) [579.155117] [167/171] (448s left) i915_suspend (basic-s3-without-i915) [579.300122] Starting subtest: basic-s3-without-i915 [602.814925] Subtest basic-s3-without-i915: SUCCESS (7.108s) [603.183746] [168/171] (441s left) gem_exec_suspend (basic-s0) [603.342085] Starting subtest: basic-S0 [603.343289] Starting dynamic subtest: smem [623.030950] Dynamic subtest smem: SUCCESS (3.963s) [623.032157] Subtest basic-S0: SUCCESS (3.965s) [623.187354] [169/171] (436s left) gem_exec_suspend (basic-s3) [623.334616] Starting subtest: basic-S3 [623.335771] Starting dynamic subtest: smem [642.172643] Dynamic subtest smem: SUCCESS (3.908s) [642.173739] Subtest basic-S3: SUCCESS (3.909s) [642.373738] [170/171] (432s left) kms_chamelium_hpd (common-hpd-after-suspend) [642.864666] Subtest common-hpd-after-suspend: SKIP (0.000s) [643.788250] [171/171] (431s left) kms_pipe_crc_basic (suspend-read-crc) [643.949199] Starting subtest: suspend-read-crc [643.950653] Starting dynamic subtest: pipe-A-eDP-1 [661.939403] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.476s) [661.961999] Starting dynamic subtest: pipe-B-eDP-1 [679.903819] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.073s) [679.926131] Starting dynamic subtest: pipe-C-eDP-1 [698.908502] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.261s) [698.909776] Subtest suspend-read-crc: SUCCESS (8.821s) [699.782810] Closing watchdogs Done.