[47.405174] Initializing watchdogs [47.405370] /dev/watchdog0 [47.416487] [001/171] (960s left) i915_module_load (load) [47.558289] Starting subtest: load [50.182730] Subtest load: SUCCESS (2.625s) [50.208213] [002/171] (957s left) core_auth (basic-auth) [50.349440] Starting subtest: basic-auth [50.350611] Subtest basic-auth: SUCCESS (0.001s) [50.442998] [003/171] (957s left) debugfs_test (read_all_entries) [50.592462] Starting subtest: read_all_entries [50.667862] Subtest read_all_entries: SUCCESS (0.075s) [50.782271] [004/171] (957s left) debugfs_test (basic-hwmon) [50.925324] Starting subtest: basic-hwmon [50.927353] Subtest basic-hwmon: SKIP (0.000s) [51.034265] [005/171] (956s left) fbdev (eof) [51.236305] Starting subtest: eof [51.237682] Subtest eof: SUCCESS (0.001s) [51.298549] [006/171] (956s left) fbdev (info) [51.453349] Starting subtest: info [51.454593] Subtest info: SUCCESS (0.000s) [51.534844] [007/171] (956s left) fbdev (nullptr) [51.684897] Starting subtest: nullptr [51.686629] Subtest nullptr: SUCCESS (0.000s) [51.752435] [008/171] (956s left) fbdev (read) [51.900227] Starting subtest: read [58.978904] Subtest read: SUCCESS (7.044s) [59.016600] [009/171] (949s left) fbdev (write) [59.167907] Starting subtest: write [62.951920] Subtest write: SUCCESS (3.750s) [63.000260] [010/171] (945s left) gem_basic (bad-close) [63.135611] Starting subtest: bad-close [63.137902] Subtest bad-close: SUCCESS (0.000s) [63.218277] [011/171] (944s left) gem_basic (create-close) [63.355380] Starting subtest: create-close [63.357596] Subtest create-close: SUCCESS (0.000s) [63.448718] [012/171] (944s left) gem_basic (create-fd-close) [63.586496] Starting subtest: create-fd-close [63.588623] Subtest create-fd-close: SUCCESS (0.000s) [63.682496] [013/171] (944s left) gem_busy (busy@all-engines) [63.830612] Starting subtest: busy [63.831858] Starting dynamic subtest: all-engines [63.895158] Dynamic subtest all-engines: SUCCESS (0.064s) [63.896220] Subtest busy: SUCCESS (0.065s) [64.284367] [014/171] (943s left) gem_close_race (basic-process) [64.445938] Starting subtest: basic-process [64.525198] Subtest basic-process: SUCCESS (0.078s) [64.734859] [015/171] (943s left) gem_close_race (basic-threads) [64.891653] Starting subtest: basic-threads [66.070102] Subtest basic-threads: SUCCESS (1.178s) [66.298078] [016/171] (941s left) gem_ctx_create (basic) [66.461132] Starting subtest: basic [66.462261] Subtest basic: SUCCESS (0.000s) [66.667795] [017/171] (941s left) gem_ctx_create (basic-files) [66.821815] Starting subtest: basic-files [68.846605] Subtest basic-files: SUCCESS (2.025s) [69.083690] [018/171] (939s left) gem_ctx_exec (basic) [69.222788] Starting subtest: basic [69.227650] Subtest basic: SUCCESS (0.005s) [69.333117] [019/171] (939s left) gem_exec_basic (basic) [69.472460] Starting subtest: basic [69.473631] Starting dynamic subtest: rcs0-smem [69.474686] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [69.486356] Starting dynamic subtest: bcs0-smem [69.487731] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [69.498340] Starting dynamic subtest: vcs0-smem [69.499781] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [69.510189] Starting dynamic subtest: vecs0-smem [69.511467] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [69.512731] Subtest basic: SUCCESS (0.005s) [69.683455] [020/171] (938s left) gem_exec_create (basic) [69.827375] Starting subtest: basic [69.828508] Starting dynamic subtest: smem [71.872345] Dynamic subtest smem: SUCCESS (2.044s) [71.873362] Subtest basic: SUCCESS (2.044s) [72.098966] [021/171] (936s left) gem_exec_fence (basic-busy) [72.415483] Starting subtest: basic-busy [72.416946] Starting dynamic subtest: rcs0 [72.436812] Dynamic subtest rcs0: SUCCESS (0.030s) [72.448546] Starting dynamic subtest: bcs0 [72.464379] Dynamic subtest bcs0: SUCCESS (0.027s) [72.476027] Starting dynamic subtest: vcs0 [72.487448] Dynamic subtest vcs0: SUCCESS (0.023s) [72.501435] Starting dynamic subtest: vecs0 [72.522681] Dynamic subtest vecs0: SUCCESS (0.034s) [72.524278] Subtest basic-busy: SUCCESS (0.116s) [73.120426] [022/171] (935s left) gem_exec_fence (basic-wait) [73.431766] Starting subtest: basic-wait [73.433224] Starting dynamic subtest: rcs0 [73.441139] Dynamic subtest rcs0: SUCCESS (0.029s) [73.454145] Starting dynamic subtest: bcs0 [73.470814] Dynamic subtest bcs0: SUCCESS (0.030s) [73.482800] Starting dynamic subtest: vcs0 [73.495957] Dynamic subtest vcs0: SUCCESS (0.025s) [73.507934] Starting dynamic subtest: vecs0 [73.531500] Dynamic subtest vecs0: SUCCESS (0.035s) [73.532820] Subtest basic-wait: SUCCESS (0.121s) [74.067711] [023/171] (934s left) gem_exec_fence (basic-await) [74.367761] Starting subtest: basic-await [74.369064] Starting dynamic subtest: rcs0 [74.461694] Dynamic subtest rcs0: SUCCESS (0.099s) [74.489300] Starting dynamic subtest: bcs0 [74.584323] Dynamic subtest bcs0: SUCCESS (0.124s) [74.612280] Starting dynamic subtest: vcs0 [74.715908] Dynamic subtest vcs0: SUCCESS (0.128s) [74.743243] Starting dynamic subtest: vecs0 [74.844486] Dynamic subtest vecs0: SUCCESS (0.129s) [74.846992] Subtest basic-await: SUCCESS (0.484s) [75.468341] [024/171] (933s left) gem_exec_fence (nb-await) [75.769468] Starting subtest: nb-await [75.770631] Starting dynamic subtest: rcs0 [75.825949] Dynamic subtest rcs0: SUCCESS (0.064s) [75.846682] Starting dynamic subtest: bcs0 [75.899494] Dynamic subtest bcs0: SUCCESS (0.071s) [75.927447] Starting dynamic subtest: vcs0 [75.975916] Dynamic subtest vcs0: SUCCESS (0.078s) [76.004241] Starting dynamic subtest: vecs0 [76.053185] Dynamic subtest vecs0: SUCCESS (0.076s) [76.055332] Subtest nb-await: SUCCESS (0.292s) [76.639478] [025/171] (931s left) gem_exec_gttfill (basic) [76.786364] Starting subtest: basic [83.493464] Subtest basic: SUCCESS (6.699s) [83.688463] [026/171] (924s left) gem_exec_parallel (engines) [83.908522] Starting subtest: engines [83.909877] Starting dynamic subtest: basic [86.438890] Dynamic subtest basic: SUCCESS (2.530s) [86.454774] Starting dynamic subtest: contexts [89.947354] Dynamic subtest contexts: SUCCESS (3.499s) [89.961125] Starting dynamic subtest: fds [94.841356] Dynamic subtest fds: SUCCESS (4.881s) [94.855225] Starting dynamic subtest: userptr [97.419202] Dynamic subtest userptr: SUCCESS (2.572s) [97.420931] Subtest engines: SUCCESS (13.483s) [97.615418] [027/171] (910s left) gem_exec_store (basic) [97.762633] Starting subtest: basic [97.817754] Subtest basic: SUCCESS (0.055s) [98.020700] [028/171] (910s left) gem_flink_basic (bad-flink) [98.157642] Starting subtest: bad-flink [98.158767] Subtest bad-flink: SUCCESS (0.000s) [98.235619] [029/171] (910s left) gem_flink_basic (bad-open) [98.372935] Starting subtest: bad-open [98.379340] Subtest bad-open: SUCCESS (0.000s) [98.452291] [030/171] (910s left) gem_flink_basic (basic) [98.589557] Starting subtest: basic [98.590662] Subtest basic: SUCCESS (0.000s) [98.686283] [031/171] (910s left) gem_flink_basic (double-flink) [98.823827] Starting subtest: double-flink [98.825062] Subtest double-flink: SUCCESS (0.000s) [98.919327] [032/171] (909s left) gem_flink_basic (flink-lifetime) [99.056864] Starting subtest: flink-lifetime [99.058071] Subtest flink-lifetime: SUCCESS (0.002s) [99.153106] [033/171] (909s left) gem_huc_copy (huc-copy) [99.294864] Starting subtest: huc-copy [99.297285] Subtest huc-copy: SKIP (0.000s) [99.402832] [034/171] (909s left) gem_linear_blits (basic) [99.689789] Starting subtest: basic [99.702448] Subtest basic: SUCCESS (0.013s) [99.839559] [035/171] (908s left) gem_mmap (basic) [100.040247] Starting subtest: basic [100.045281] Subtest basic: SUCCESS (0.001s) [100.136170] [036/171] (908s left) gem_mmap_gtt (basic) [100.266767] Starting subtest: basic [100.268092] Subtest basic: SUCCESS (0.001s) [100.351193] [037/171] (908s left) gem_render_linear_blits (basic) [100.492249] Starting subtest: basic [100.542566] Subtest basic: SUCCESS (0.050s) [100.617580] [038/171] (908s left) gem_render_tiled_blits (basic) [100.763172] Starting subtest: basic [100.824164] Subtest basic: SUCCESS (0.061s) [100.886603] [039/171] (908s left) gem_ringfill (basic-all) [101.170933] Starting subtest: basic-all [102.394145] Subtest basic-all: SUCCESS (1.216s) [102.474450] [040/171] (906s left) gem_softpin (allocator-basic) [102.625215] Starting subtest: allocator-basic [102.797608] Subtest allocator-basic: SUCCESS (0.164s) [102.902768] [041/171] (906s left) gem_softpin (allocator-basic-reserve) [103.053946] Starting subtest: allocator-basic-reserve [103.225416] Subtest allocator-basic-reserve: SUCCESS (0.163s) [103.338741] [042/171] (905s left) gem_softpin (safe-alignment) [103.487281] Starting subtest: safe-alignment [103.507340] Subtest safe-alignment: SUCCESS (0.020s) [103.619381] [043/171] (905s left) gem_sync (basic-all) [103.770989] Starting subtest: basic-all [105.994473] Subtest basic-all: SUCCESS (2.223s) [106.218780] [044/171] (902s left) gem_sync (basic-each) [106.376786] Starting subtest: basic-each [108.730198] Subtest basic-each: SUCCESS (2.353s) [108.942065] [045/171] (900s left) gem_tiled_blits (basic) [109.245565] Starting subtest: basic [109.277664] Subtest basic: SUCCESS (0.032s) [109.407668] [046/171] (899s left) gem_tiled_fence_blits (basic) [109.761150] Starting subtest: basic [109.787966] Subtest basic: SUCCESS (0.029s) [109.934888] [047/171] (899s left) gem_tiled_pread_basic [110.471412] [048/171] (898s left) gem_wait (busy@all-engines) [110.627453] Starting subtest: busy [110.628621] Starting dynamic subtest: all-engines [111.160616] Dynamic subtest all-engines: SUCCESS (0.533s) [111.161784] Subtest busy: SUCCESS (0.533s) [111.405288] [049/171] (897s left) gem_wait (wait@all-engines) [111.565547] Starting subtest: wait [111.566692] Starting dynamic subtest: all-engines [112.618040] Dynamic subtest all-engines: SUCCESS (1.051s) [112.620043] Subtest wait: SUCCESS (1.051s) [112.870513] [050/171] (896s left) i915_getparams_basic (basic-eu-total) [113.005623] Starting subtest: basic-eu-total [113.007838] Subtest basic-eu-total: SUCCESS (0.000s) [113.086660] [051/171] (896s left) i915_getparams_basic (basic-subslice-total) [113.222617] Starting subtest: basic-subslice-total [113.224874] Subtest basic-subslice-total: SUCCESS (0.000s) [113.303069] [052/171] (895s left) i915_hangman (error-state-basic) [113.447549] Starting subtest: error-state-basic [113.461138] Subtest error-state-basic: SUCCESS (0.013s) [113.553326] [053/171] (895s left) i915_pciid [113.769996] [054/171] (895s left) kms_addfb_basic (addfb25-bad-modifier) [113.901654] Starting subtest: addfb25-bad-modifier [113.902771] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [114.036040] [055/171] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [114.173798] Starting subtest: addfb25-framebuffer-vs-set-tiling [114.174929] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.324499] [056/171] (895s left) kms_addfb_basic (addfb25-modifier-no-flag) [114.461527] Starting subtest: addfb25-modifier-no-flag [114.462574] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [114.585745] [057/171] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy) [114.723858] Starting subtest: addfb25-x-tiled-legacy [114.725074] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [114.852801] [058/171] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [114.990226] Starting subtest: addfb25-x-tiled-mismatch-legacy [114.991314] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [115.119115] [059/171] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [115.284097] Starting subtest: addfb25-yf-tiled-legacy [115.285261] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [115.386438] [060/171] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy) [115.552512] Starting subtest: addfb25-y-tiled-legacy [115.553607] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [115.652893] [061/171] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [115.820201] Starting subtest: addfb25-y-tiled-small-legacy [115.821332] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [115.938716] [062/171] (893s left) kms_addfb_basic (bad-pitch-0) [116.077186] Starting subtest: bad-pitch-0 [116.078241] Subtest bad-pitch-0: SUCCESS (0.000s) [116.203318] [063/171] (893s left) kms_addfb_basic (bad-pitch-1024) [116.339704] Starting subtest: bad-pitch-1024 [116.340815] Subtest bad-pitch-1024: SUCCESS (0.000s) [116.469374] [064/171] (893s left) kms_addfb_basic (bad-pitch-128) [116.605560] Starting subtest: bad-pitch-128 [116.606696] Subtest bad-pitch-128: SUCCESS (0.000s) [116.736279] [065/171] (892s left) kms_addfb_basic (bad-pitch-256) [116.872816] Starting subtest: bad-pitch-256 [116.873955] Subtest bad-pitch-256: SUCCESS (0.000s) [117.003281] [066/171] (892s left) kms_addfb_basic (bad-pitch-32) [117.139586] Starting subtest: bad-pitch-32 [117.140776] Subtest bad-pitch-32: SUCCESS (0.000s) [117.252302] [067/171] (892s left) kms_addfb_basic (bad-pitch-63) [117.389416] Starting subtest: bad-pitch-63 [117.390518] Subtest bad-pitch-63: SUCCESS (0.000s) [117.519139] [068/171] (892s left) kms_addfb_basic (bad-pitch-65536) [117.654556] Starting subtest: bad-pitch-65536 [117.655682] Subtest bad-pitch-65536: SUCCESS (0.000s) [117.786764] [069/171] (891s left) kms_addfb_basic (bad-pitch-999) [117.922640] Starting subtest: bad-pitch-999 [117.923768] Subtest bad-pitch-999: SUCCESS (0.000s) [118.053304] [070/171] (891s left) kms_addfb_basic (basic) [118.189556] Starting subtest: basic [118.190871] Subtest basic: SUCCESS (0.000s) [118.302720] [071/171] (891s left) kms_addfb_basic (basic-x-tiled-legacy) [118.439842] Starting subtest: basic-x-tiled-legacy [118.440977] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [118.569837] [072/171] (891s left) kms_addfb_basic (basic-y-tiled-legacy) [118.708434] Starting subtest: basic-y-tiled-legacy [118.709464] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [118.836044] [073/171] (891s left) kms_addfb_basic (bo-too-small) [119.002647] Starting subtest: bo-too-small [119.003727] Subtest bo-too-small: SUCCESS (0.000s) [119.102625] [074/171] (890s left) kms_addfb_basic (bo-too-small-due-to-tiling) [119.267215] Starting subtest: bo-too-small-due-to-tiling [119.268361] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [119.369015] [075/171] (890s left) kms_addfb_basic (clobberred-modifier) [119.506531] Starting subtest: clobberred-modifier [119.507646] Subtest clobberred-modifier: SUCCESS (0.000s) [119.635870] [076/171] (890s left) kms_addfb_basic (framebuffer-vs-set-tiling) [119.773258] Starting subtest: framebuffer-vs-set-tiling [119.774294] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [119.905472] [077/171] (890s left) kms_addfb_basic (invalid-get-prop) [120.043876] Starting subtest: invalid-get-prop [120.045054] Subtest invalid-get-prop: SUCCESS (0.000s) [120.169276] [078/171] (889s left) kms_addfb_basic (invalid-get-prop-any) [120.306738] Starting subtest: invalid-get-prop-any [120.307940] Subtest invalid-get-prop-any: SUCCESS (0.000s) [120.436920] [079/171] (889s left) kms_addfb_basic (invalid-set-prop) [120.575537] Starting subtest: invalid-set-prop [120.576674] Subtest invalid-set-prop: SUCCESS (0.000s) [120.703101] [080/171] (889s left) kms_addfb_basic (invalid-set-prop-any) [120.841439] Starting subtest: invalid-set-prop-any [120.842607] Subtest invalid-set-prop-any: SUCCESS (0.000s) [120.969552] [081/171] (889s left) kms_addfb_basic (no-handle) [121.106860] Starting subtest: no-handle [121.108224] Subtest no-handle: SUCCESS (0.000s) [121.236396] [082/171] (888s left) kms_addfb_basic (size-max) [121.402666] Starting subtest: size-max [121.403782] Subtest size-max: SUCCESS (0.000s) [121.502623] [083/171] (888s left) kms_addfb_basic (small-bo) [121.670223] Starting subtest: small-bo [121.671285] Subtest small-bo: SUCCESS (0.000s) [121.768856] [084/171] (888s left) kms_addfb_basic (tile-pitch-mismatch) [121.906873] Starting subtest: tile-pitch-mismatch [121.908021] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [122.036436] [085/171] (888s left) kms_addfb_basic (too-high) [122.211399] Starting subtest: too-high [122.212439] Subtest too-high: SUCCESS (0.001s) [122.303018] [086/171] (887s left) kms_addfb_basic (too-wide) [122.467523] Starting subtest: too-wide [122.468847] Subtest too-wide: SUCCESS (0.000s) [122.569483] [087/171] (887s left) kms_addfb_basic (unused-handle) [122.700834] Starting subtest: unused-handle [122.702017] Subtest unused-handle: SUCCESS (0.000s) [122.836589] [088/171] (887s left) kms_addfb_basic (unused-modifier) [122.973400] Starting subtest: unused-modifier [122.974491] Subtest unused-modifier: SUCCESS (0.000s) [123.102994] [089/171] (887s left) kms_addfb_basic (unused-offsets) [123.239998] Starting subtest: unused-offsets [123.241336] Subtest unused-offsets: SUCCESS (0.000s) [123.370056] [090/171] (886s left) kms_addfb_basic (unused-pitches) [123.506412] Starting subtest: unused-pitches [123.507570] Subtest unused-pitches: SUCCESS (0.000s) [123.636306] [091/171] (886s left) kms_busy (basic) [123.801736] Starting subtest: basic [123.802865] Starting dynamic subtest: flip [124.870843] Dynamic subtest flip: SUCCESS (1.068s) [124.890027] Starting dynamic subtest: modeset [128.754307] Dynamic subtest modeset: SUCCESS (3.880s) [128.755372] Subtest basic: SUCCESS (4.951s) [129.725811] [092/171] (880s left) kms_chamelium_hpd (dp-hpd-fast) [130.208506] Subtest dp-hpd-fast: SKIP (0.000s) [131.082455] [093/171] (879s left) kms_chamelium_edid (dp-edid-read) [131.565425] Subtest dp-edid-read: SKIP (0.000s) [132.427481] [094/171] (878s left) kms_chamelium_frames (dp-crc-fast) [132.906503] Subtest dp-crc-fast: SKIP (0.000s) [133.769785] [095/171] (876s left) kms_chamelium_hpd (hdmi-hpd-fast) [134.250398] Subtest hdmi-hpd-fast: SKIP (0.000s) [135.112981] [096/171] (875s left) kms_chamelium_edid (hdmi-edid-read) [135.596371] Subtest hdmi-edid-read: SKIP (0.000s) [136.457100] [097/171] (874s left) kms_chamelium_frames (hdmi-crc-fast) [136.939520] Subtest hdmi-crc-fast: SKIP (0.000s) [137.799192] [098/171] (872s left) kms_chamelium_hpd (vga-hpd-fast) [138.279249] Subtest vga-hpd-fast: SKIP (0.000s) [139.145182] [099/171] (871s left) kms_chamelium_edid (vga-edid-read) [139.625337] Subtest vga-edid-read: SKIP (0.000s) [140.490885] [100/171] (870s left) kms_prop_blob (basic) [140.620556] Starting subtest: basic [140.621779] Subtest basic: SUCCESS (0.000s) [140.711453] [101/171] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [140.871450] Starting subtest: basic-busy-flip-before-cursor-atomic [140.873722] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [140.956675] [102/171] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [141.121553] Starting subtest: basic-busy-flip-before-cursor-legacy [141.124039] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [141.206439] [103/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [141.372336] Starting subtest: basic-flip-after-cursor-atomic [142.635705] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.264s) [143.547158] [104/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [143.713841] Starting subtest: basic-flip-after-cursor-legacy [145.005286] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.292s) [145.979398] [105/171] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [146.144869] Starting subtest: basic-flip-after-cursor-varying-size [147.422995] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.277s) [148.348334] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [148.514905] Starting subtest: basic-flip-before-cursor-atomic [149.791199] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.276s) [150.727634] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [150.893675] Starting subtest: basic-flip-before-cursor-legacy [152.169260] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.276s) [153.149186] [108/171] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [153.311873] Starting subtest: basic-flip-before-cursor-varying-size [154.578189] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.267s) [155.514895] [109/171] (855s left) kms_flip (basic-flip-vs-dpms) [155.653564] Starting subtest: basic-flip-vs-dpms [155.656669] Starting dynamic subtest: A-eDP1 [158.534830] Dynamic subtest A-eDP1: SUCCESS (2.878s) [158.552090] Starting dynamic subtest: B-eDP1 [160.888057] Dynamic subtest B-eDP1: SUCCESS (2.352s) [160.905176] Starting dynamic subtest: C-eDP1 [163.258194] Dynamic subtest C-eDP1: SUCCESS (2.368s) [163.260770] Subtest basic-flip-vs-dpms: SUCCESS (7.608s) [164.165185] [110/171] (846s left) kms_flip (basic-flip-vs-modeset) [164.313089] Starting subtest: basic-flip-vs-modeset [164.316256] Starting dynamic subtest: A-eDP1 [167.172911] Dynamic subtest A-eDP1: SUCCESS (2.856s) [167.189559] Starting dynamic subtest: B-eDP1 [169.588950] Dynamic subtest B-eDP1: SUCCESS (2.415s) [169.608396] Starting dynamic subtest: C-eDP1 [171.939834] Dynamic subtest C-eDP1: SUCCESS (2.350s) [171.944792] Subtest basic-flip-vs-modeset: SUCCESS (7.630s) [172.860742] [111/171] (838s left) kms_flip (basic-flip-vs-wf_vblank) [173.006398] Starting subtest: basic-flip-vs-wf_vblank [173.009440] Starting dynamic subtest: A-eDP1 [175.324131] Dynamic subtest A-eDP1: SUCCESS (2.315s) [175.341143] Starting dynamic subtest: B-eDP1 [177.610596] Dynamic subtest B-eDP1: SUCCESS (2.285s) [177.628569] Starting dynamic subtest: C-eDP1 [179.850687] Dynamic subtest C-eDP1: SUCCESS (2.239s) [179.854602] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.849s) [181.182340] [112/171] (829s left) kms_flip (basic-plain-flip) [181.327223] Starting subtest: basic-plain-flip [181.330469] Starting dynamic subtest: A-eDP1 [183.357189] Dynamic subtest A-eDP1: SUCCESS (2.027s) [183.374434] Starting dynamic subtest: B-eDP1 [185.327292] Dynamic subtest B-eDP1: SUCCESS (1.969s) [185.346496] Starting dynamic subtest: C-eDP1 [187.311955] Dynamic subtest C-eDP1: SUCCESS (1.983s) [187.314912] Subtest basic-plain-flip: SUCCESS (5.989s) [188.608153] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [188.745586] Starting subtest: force-connector-state [190.467718] Subtest force-connector-state: SUCCESS (1.722s) [191.093117] [114/171] (819s left) kms_force_connector_basic (force-edid) [191.229728] Starting subtest: force-edid [191.483498] Subtest force-edid: SUCCESS (0.253s) [191.609488] [115/171] (819s left) kms_force_connector_basic (force-load-detect) [191.747550] Starting subtest: force-load-detect [191.749767] Subtest force-load-detect: SKIP (0.000s) [191.859591] [116/171] (819s left) kms_force_connector_basic (prune-stale-modes) [191.998889] Starting subtest: prune-stale-modes [192.302985] Subtest prune-stale-modes: SUCCESS (0.305s) [192.442609] [117/171] (818s left) kms_frontbuffer_tracking (basic) [192.616550] Starting subtest: basic [195.891390] Subtest basic: SUCCESS (3.274s) [195.994233] [118/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [196.157315] Starting subtest: compare-crc-sanitycheck-xr24 [196.158919] Starting dynamic subtest: pipe-A-eDP-1 [196.828511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.669s) [196.848519] Starting dynamic subtest: pipe-B-eDP-1 [198.207106] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s) [198.236665] Starting dynamic subtest: pipe-C-eDP-1 [199.750511] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.539s) [199.751698] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.594s) [200.694384] [119/171] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [200.861836] Starting subtest: compare-crc-sanitycheck-nv12 [200.864765] Starting dynamic subtest: pipe-A-eDP-1 [201.784683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [201.810623] Starting dynamic subtest: pipe-B-eDP-1 [203.239807] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s) [203.266136] Starting dynamic subtest: pipe-C-eDP-1 [205.020227] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.770s) [205.021544] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.152s) [205.944618] [120/171] (805s left) kms_pipe_crc_basic (hang-read-crc) [206.113432] Starting subtest: hang-read-crc [206.114693] Starting dynamic subtest: pipe-A-eDP-1 [208.422610] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.308s) [208.442454] Starting dynamic subtest: pipe-B-eDP-1 [211.395376] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.969s) [211.415253] Starting dynamic subtest: pipe-C-eDP-1 [214.734155] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.335s) [214.735390] Subtest hang-read-crc: SUCCESS (8.623s) [215.670654] [121/171] (795s left) kms_pipe_crc_basic (nonblocking-crc) [215.839222] Starting subtest: nonblocking-crc [215.842263] Starting dynamic subtest: pipe-A-eDP-1 [216.694862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [216.714367] Starting dynamic subtest: pipe-B-eDP-1 [218.247798] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [218.266931] Starting dynamic subtest: pipe-C-eDP-1 [219.963218] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.712s) [219.964415] Subtest nonblocking-crc: SUCCESS (4.125s) [220.919436] [122/171] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [221.095451] Starting subtest: nonblocking-crc-frame-sequence [221.098764] Starting dynamic subtest: pipe-A-eDP-1 [221.943649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s) [221.962665] Starting dynamic subtest: pipe-B-eDP-1 [223.495518] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [223.514989] Starting dynamic subtest: pipe-C-eDP-1 [225.236694] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.737s) [225.237812] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.142s) [226.166660] [123/171] (785s left) kms_pipe_crc_basic (read-crc) [226.335225] Starting subtest: read-crc [226.338672] Starting dynamic subtest: pipe-A-eDP-1 [227.126284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s) [227.146096] Starting dynamic subtest: pipe-B-eDP-1 [228.624540] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s) [228.642565] Starting dynamic subtest: pipe-C-eDP-1 [230.275430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [230.276522] Subtest read-crc: SUCCESS (3.941s) [231.222774] [124/171] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence) [231.389583] Starting subtest: read-crc-frame-sequence [231.392892] Starting dynamic subtest: pipe-A-eDP-1 [232.182116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s) [232.201052] Starting dynamic subtest: pipe-B-eDP-1 [233.678985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s) [233.699189] Starting dynamic subtest: pipe-C-eDP-1 [235.324104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.643s) [235.325311] Subtest read-crc-frame-sequence: SUCCESS (3.935s) [236.279551] [125/171] (775s left) kms_psr (primary_page_flip) [236.444612] Starting subtest: primary_page_flip [240.699622] Subtest primary_page_flip: SUCCESS (4.255s) [241.655154] [126/171] (769s left) kms_psr (cursor_plane_move) [241.831344] Starting subtest: cursor_plane_move [246.039578] Subtest cursor_plane_move: SUCCESS (4.208s) [246.967753] [127/171] (764s left) kms_psr (sprite_plane_onoff) [247.142384] Starting subtest: sprite_plane_onoff [251.445351] Subtest sprite_plane_onoff: SUCCESS (4.295s) [252.405974] [128/171] (759s left) kms_psr (primary_mmap_gtt) [252.575446] Starting subtest: primary_mmap_gtt [256.806845] Subtest primary_mmap_gtt: SUCCESS (4.231s) [257.719379] [129/171] (753s left) kms_setmode (basic-clone-single-crtc) [257.853572] Starting subtest: basic-clone-single-crtc [257.857072] Subtest basic-clone-single-crtc: SKIP (0.000s) [257.934272] [130/171] (753s left) i915_pm_backlight (basic-brightness) [258.094383] Starting subtest: basic-brightness [258.198941] Starting dynamic subtest: eDP-1 [258.760376] Dynamic subtest eDP-1: SUCCESS (0.561s) [258.761607] Subtest basic-brightness: SUCCESS (0.667s) [259.702854] [131/171] (751s left) i915_pm_rpm (basic-pci-d3-state) [261.574672] Starting subtest: basic-pci-d3-state [265.940479] Subtest basic-pci-d3-state: SUCCESS (4.364s) [266.139962] [132/171] (745s left) i915_pm_rpm (basic-rte) [266.276732] Starting subtest: basic-rte [272.399722] Subtest basic-rte: SUCCESS (6.127s) [273.873035] [133/171] (737s left) i915_pm_rps (basic-api) [274.043440] Starting subtest: basic-api [274.052899] Subtest basic-api: SUCCESS (0.004s) [274.122075] [134/171] (737s left) prime_self_import (basic-llseek-bad) [274.280869] Starting subtest: basic-llseek-bad [274.299305] Subtest basic-llseek-bad: SUCCESS (0.003s) [274.371801] [135/171] (737s left) prime_self_import (basic-llseek-size) [274.520353] Starting subtest: basic-llseek-size [274.536951] Subtest basic-llseek-size: SUCCESS (0.004s) [274.605096] [136/171] (737s left) prime_self_import (basic-with_fd_dup) [274.763314] Starting subtest: basic-with_fd_dup [274.779164] Subtest basic-with_fd_dup: SUCCESS (0.005s) [274.855271] [137/171] (736s left) prime_self_import (basic-with_one_bo) [275.012250] Starting subtest: basic-with_one_bo [275.029075] Subtest basic-with_one_bo: SUCCESS (0.005s) [275.086753] [138/171] (736s left) prime_self_import (basic-with_one_bo_two_files) [275.247413] Starting subtest: basic-with_one_bo_two_files [275.263443] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [275.338650] [139/171] (736s left) prime_self_import (basic-with_two_bos) [275.522519] Starting subtest: basic-with_two_bos [275.533699] Subtest basic-with_two_bos: SUCCESS (0.005s) [275.621831] [140/171] (736s left) prime_vgem (basic-fence-flip) [275.797664] Starting subtest: basic-fence-flip [276.249406] Subtest basic-fence-flip: SUCCESS (0.468s) [276.372847] [141/171] (735s left) prime_vgem (basic-fence-mmap) [276.557653] Starting subtest: basic-fence-mmap [276.601654] Subtest basic-fence-mmap: SUCCESS (0.048s) [276.689684] [142/171] (735s left) prime_vgem (basic-fence-read) [276.903348] Starting subtest: basic-fence-read [276.957954] Subtest basic-fence-read: SUCCESS (0.074s) [277.039139] [143/171] (734s left) prime_vgem (basic-gtt) [277.207164] Starting subtest: basic-gtt [277.225807] Subtest basic-gtt: SUCCESS (0.023s) [277.322617] [144/171] (734s left) prime_vgem (basic-read) [277.517728] Starting subtest: basic-read [277.552369] Subtest basic-read: SUCCESS (0.035s) [277.638927] [145/171] (734s left) prime_vgem (basic-write) [277.814474] Starting subtest: basic-write [277.847163] Subtest basic-write: SUCCESS (0.041s) [277.922281] [146/171] (734s left) vgem_basic (setversion) [278.097649] Starting subtest: setversion [278.112080] Subtest setversion: SUCCESS (0.000s) [278.174376] [147/171] (733s left) vgem_basic (create) [278.351624] Starting subtest: create [278.357913] Subtest create: SUCCESS (0.000s) [278.424881] [148/171] (733s left) vgem_basic (debugfs) [278.622409] Starting subtest: debugfs [278.637587] Subtest debugfs: SUCCESS (0.001s) [278.674236] [149/171] (733s left) vgem_basic (dmabuf-export) [278.849811] Starting subtest: dmabuf-export [278.874738] Subtest dmabuf-export: SUCCESS (0.025s) [278.981088] [150/171] (733s left) vgem_basic (dmabuf-fence) [279.206038] Starting subtest: dmabuf-fence [279.209898] Subtest dmabuf-fence: SUCCESS (0.001s) [279.239369] [151/171] (733s left) vgem_basic (dmabuf-fence-before) [279.424979] Starting subtest: dmabuf-fence-before [279.439965] Subtest dmabuf-fence-before: SUCCESS (0.001s) [279.489911] [152/171] (732s left) vgem_basic (dmabuf-mmap) [279.717078] Starting subtest: dmabuf-mmap [279.718389] Subtest dmabuf-mmap: SUCCESS (0.026s) [279.789725] [153/171] (732s left) vgem_basic (mmap) [279.971311] Starting subtest: mmap [279.978942] Subtest mmap: SUCCESS (0.017s) [280.043170] [154/171] (732s left) vgem_basic (second-client) [280.219495] Starting subtest: second-client [280.275911] Subtest second-client: SUCCESS (0.032s) [280.311070] [155/171] (732s left) vgem_basic (sysfs) [280.451750] Starting subtest: sysfs [280.453204] Subtest sysfs: SUCCESS (0.001s) [280.522845] [156/171] (731s left) core_hotunplug (unbind-rebind) [280.702390] Starting subtest: unbind-rebind [283.206789] Subtest unbind-rebind: SUCCESS (2.504s) [283.246362] [157/171] (729s left) vgem_basic (unload) [283.387334] Starting subtest: unload [312.413892] Subtest unload: SUCCESS (28.991s) [312.531152] [158/171] (699s left) i915_module_load (reload) [312.660115] Starting subtest: reload [316.271291] Subtest reload: SUCCESS (3.611s) [316.305429] [159/171] (696s left) gem_lmem_swapping (basic) [316.460917] Subtest basic: SKIP (0.000s) [316.506805] [160/171] (696s left) gem_lmem_swapping (parallel-random-engines) [316.652247] Subtest parallel-random-engines: SKIP (0.000s) [316.705554] [161/171] (695s left) gem_lmem_swapping (random-engines) [316.849762] Subtest random-engines: SKIP (0.000s) [316.905925] [162/171] (695s left) gem_lmem_swapping (verify-random) [317.051334] Subtest verify-random: SKIP (0.000s) [317.106059] [163/171] (695s left) i915_pm_rpm (module-reload) [329.624237] Starting subtest: module-reload [364.604544] Subtest module-reload: SUCCESS (34.975s) [364.631226] [164/171] (648s left) i915_selftest (live) [364.774393] Starting subtest: live [364.775850] Starting dynamic subtest: sanitycheck [366.625347] Dynamic subtest sanitycheck: SUCCESS (1.841s) [366.640097] Starting dynamic subtest: uncore [368.537431] Dynamic subtest uncore: SUCCESS (1.909s) [368.552048] Starting dynamic subtest: workarounds [370.605479] Dynamic subtest workarounds: SUCCESS (2.064s) [370.619993] Starting dynamic subtest: gt_engines [372.914176] Dynamic subtest gt_engines: SUCCESS (2.305s) [372.929127] Starting dynamic subtest: gt_timelines [385.776610] Dynamic subtest gt_timelines: SUCCESS (12.859s) [385.791307] Starting dynamic subtest: gt_contexts [387.685521] Dynamic subtest gt_contexts: SUCCESS (1.905s) [387.699964] Starting dynamic subtest: gt_lrc [392.123427] Dynamic subtest gt_lrc: SUCCESS (4.434s) [392.138175] Starting dynamic subtest: gt_mocs [394.093583] Dynamic subtest gt_mocs: SUCCESS (1.967s) [394.108100] Starting dynamic subtest: gt_pm [399.153564] Dynamic subtest gt_pm: SUCCESS (5.056s) [399.168459] Starting dynamic subtest: gt_heartbeat [401.053266] Dynamic subtest gt_heartbeat: SUCCESS (1.896s) [401.068304] Starting dynamic subtest: gt_tlb [404.204824] Dynamic subtest gt_tlb: SUCCESS (3.148s) [404.219944] Starting dynamic subtest: requests [411.794687] Dynamic subtest requests: SUCCESS (7.586s) [411.809443] Starting dynamic subtest: migrate [416.414542] Dynamic subtest migrate: SUCCESS (4.616s) [416.429502] Starting dynamic subtest: active [418.284790] Dynamic subtest active: SUCCESS (1.867s) [418.299497] Starting dynamic subtest: objects [421.855161] Dynamic subtest objects: SUCCESS (3.567s) [421.870174] Starting dynamic subtest: mman [428.813563] Dynamic subtest mman: SUCCESS (6.955s) [428.828203] Starting dynamic subtest: dmabuf [430.683238] Dynamic subtest dmabuf: SUCCESS (1.866s) [430.698501] Starting dynamic subtest: vma [432.532524] Dynamic subtest vma: SUCCESS (1.846s) [432.547613] Starting dynamic subtest: coherency [437.099600] Dynamic subtest coherency: SUCCESS (4.564s) [437.114542] Starting dynamic subtest: gtt [446.662566] Dynamic subtest gtt: SUCCESS (9.559s) [446.677518] Starting dynamic subtest: gem [448.627046] Dynamic subtest gem: SUCCESS (1.961s) [448.642194] Starting dynamic subtest: evict [452.518164] Dynamic subtest evict: SUCCESS (3.889s) [452.533317] Starting dynamic subtest: hugepages [460.339435] Dynamic subtest hugepages: SUCCESS (7.818s) [460.355025] Starting dynamic subtest: gem_contexts [475.856481] Dynamic subtest gem_contexts: SUCCESS (15.514s) [475.871826] Starting dynamic subtest: client [477.736698] Dynamic subtest client: SUCCESS (1.877s) [477.751891] Starting dynamic subtest: gem_migrate [479.581285] Dynamic subtest gem_migrate: SUCCESS (1.841s) [479.596969] Starting dynamic subtest: reset [484.995061] Dynamic subtest reset: SUCCESS (5.410s) [485.010449] Starting dynamic subtest: memory_region [486.818596] Dynamic subtest memory_region: SUCCESS (1.820s) [486.833822] Starting dynamic subtest: hangcheck [511.185290] Dynamic subtest hangcheck: SUCCESS (24.363s) [511.201069] Starting dynamic subtest: execlists [521.407566] Dynamic subtest execlists: SUCCESS (10.219s) [521.423069] Starting dynamic subtest: ring_submission [523.311813] Dynamic subtest ring_submission: SUCCESS (1.901s) [523.327435] Starting dynamic subtest: perf [525.281066] Dynamic subtest perf: SUCCESS (1.965s) [525.297216] Starting dynamic subtest: slpc [527.129316] Dynamic subtest slpc: SUCCESS (1.845s) [527.144965] Starting dynamic subtest: guc [528.991989] Dynamic subtest guc: SUCCESS (1.859s) [529.007732] Starting dynamic subtest: guc_multi_lrc [530.850348] Dynamic subtest guc_multi_lrc: SUCCESS (1.855s) [530.866105] Starting dynamic subtest: guc_hang [532.701469] Dynamic subtest guc_hang: SUCCESS (1.848s) [532.717044] Starting dynamic subtest: late_gt_pm [534.619126] Dynamic subtest late_gt_pm: SUCCESS (1.914s) [534.620411] Subtest live: SUCCESS (169.838s) [534.816204] [165/171] (477s left) dmabuf (all-tests) [534.955928] Starting subtest: all-tests [534.957282] Starting dynamic subtest: sanitycheck [535.025864] Dynamic subtest sanitycheck: SUCCESS (0.068s) [535.046747] Starting dynamic subtest: dma_fence [535.211074] Dynamic subtest dma_fence: SUCCESS (0.181s) [535.228149] Starting dynamic subtest: dma_fence_chain [553.235065] Dynamic subtest dma_fence_chain: SUCCESS (18.012s) [553.248207] Starting dynamic subtest: dma_fence_unwrap [553.295729] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s) [553.314828] Starting dynamic subtest: dma_resv [553.377708] Dynamic subtest dma_resv: SUCCESS (0.078s) [553.379862] Subtest all-tests: SUCCESS (18.423s) [553.412075] [166/171] (459s left) i915_suspend (basic-s2idle-without-i915) [553.541354] Starting subtest: basic-s2idle-without-i915 [576.984570] Subtest basic-s2idle-without-i915: SUCCESS (8.851s) [577.302935] [167/171] (450s left) i915_suspend (basic-s3-without-i915) [577.439710] Starting subtest: basic-s3-without-i915 [601.012224] Subtest basic-s3-without-i915: SUCCESS (7.783s) [601.353160] [168/171] (441s left) gem_exec_suspend (basic-s0) [601.509176] Starting subtest: basic-S0 [601.510361] Starting dynamic subtest: smem [621.109115] Dynamic subtest smem: SUCCESS (3.967s) [621.110229] Subtest basic-S0: SUCCESS (3.969s) [621.268826] [169/171] (437s left) gem_exec_suspend (basic-s3) [621.416338] Starting subtest: basic-S3 [621.417512] Starting dynamic subtest: smem [640.117907] Dynamic subtest smem: SUCCESS (3.788s) [640.119216] Subtest basic-S3: SUCCESS (3.790s) [640.272918] [170/171] (433s left) kms_chamelium_hpd (common-hpd-after-suspend) [640.783298] Subtest common-hpd-after-suspend: SKIP (0.000s) [641.675881] [171/171] (432s left) kms_pipe_crc_basic (suspend-read-crc) [641.837486] Starting subtest: suspend-read-crc [641.840706] Starting dynamic subtest: pipe-A-eDP-1 [660.043451] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.444s) [660.066532] Starting dynamic subtest: pipe-B-eDP-1 [677.986458] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.056s) [678.008563] Starting dynamic subtest: pipe-C-eDP-1 [696.984459] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.245s) [696.985668] Subtest suspend-read-crc: SUCCESS (8.757s) [697.862244] Closing watchdogs Done.