[42.203108] Initializing watchdogs [42.203212] /dev/watchdog0 [42.209738] [001/165] (960s left) i915_module_load (load) [42.279792] Starting subtest: load [43.286207] Subtest load: SUCCESS (1.004s) [43.308322] [002/165] (959s left) core_auth (basic-auth) [43.390850] Starting subtest: basic-auth [43.392258] Subtest basic-auth: SUCCESS (0.001s) [43.477483] [003/165] (959s left) debugfs_test (read_all_entries) [43.598151] Starting subtest: read_all_entries [43.687228] Subtest read_all_entries: SUCCESS (0.089s) [43.790152] [004/165] (958s left) debugfs_test (basic-hwmon) [43.877306] Starting subtest: basic-hwmon [43.879399] Subtest basic-hwmon: SKIP (0.000s) [43.999181] [005/165] (958s left) fbdev (eof) [44.076849] Starting subtest: eof [44.078114] Subtest eof: SUCCESS (0.001s) [44.140787] [006/165] (958s left) fbdev (info) [44.216514] Starting subtest: info [44.217647] Subtest info: SUCCESS (0.000s) [44.281386] [007/165] (958s left) fbdev (nullptr) [44.359739] Starting subtest: nullptr [44.360892] Subtest nullptr: SUCCESS (0.000s) [44.422656] [008/165] (958s left) fbdev (read) [44.510296] Starting subtest: read [45.379111] Subtest read: SUCCESS (0.861s) [45.432278] [009/165] (957s left) fbdev (write) [45.510574] Starting subtest: write [45.932095] Subtest write: SUCCESS (0.413s) [45.971254] [010/165] (956s left) gem_basic (bad-close) [46.047442] Starting subtest: bad-close [46.049587] Subtest bad-close: SUCCESS (0.000s) [46.104850] [011/165] (956s left) gem_basic (create-close) [46.173702] Starting subtest: create-close [46.175744] Subtest create-close: SUCCESS (0.000s) [46.267253] [012/165] (956s left) gem_basic (create-fd-close) [46.338058] Starting subtest: create-fd-close [46.339792] Subtest create-fd-close: SUCCESS (0.000s) [46.432669] [013/165] (956s left) gem_busy (busy@all-engines) [46.524596] Starting subtest: busy [46.525688] Starting dynamic subtest: all-engines [46.587156] Dynamic subtest all-engines: SUCCESS (0.063s) [46.588183] Subtest busy: SUCCESS (0.063s) [47.053635] [014/165] (955s left) gem_close_race (basic-process) [47.142256] Starting subtest: basic-process [47.205488] Subtest basic-process: SUCCESS (0.063s) [47.444783] [015/165] (955s left) gem_close_race (basic-threads) [47.537207] Starting subtest: basic-threads [48.688692] Subtest basic-threads: SUCCESS (1.152s) [48.932072] [016/165] (954s left) gem_ctx_create (basic) [49.030089] Starting subtest: basic [49.031089] Subtest basic: SUCCESS (0.000s) [49.271905] [017/165] (953s left) gem_ctx_create (basic-files) [49.354708] Starting subtest: basic-files [51.376703] Subtest basic-files: SUCCESS (2.022s) [51.668262] [018/165] (951s left) gem_ctx_exec (basic) [51.743519] Starting subtest: basic [51.748208] Subtest basic: SUCCESS (0.004s) [51.899413] [019/165] (951s left) gem_exec_basic (basic) [51.984341] Starting subtest: basic [51.985362] Starting dynamic subtest: rcs0-smem [51.986251] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [51.993694] Starting dynamic subtest: bcs0-smem [51.994704] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [52.001957] Starting dynamic subtest: vcs0-smem [52.003533] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [52.010802] Starting dynamic subtest: vecs0-smem [52.012439] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [52.014071] Subtest basic: SUCCESS (0.007s) [52.274170] [020/165] (950s left) gem_exec_create (basic) [52.359026] Starting subtest: basic [52.359929] Starting dynamic subtest: smem [54.401568] Dynamic subtest smem: SUCCESS (2.043s) [54.402605] Subtest basic: SUCCESS (2.043s) [54.637753] [021/165] (948s left) gem_exec_fence (basic-busy) [54.875370] Starting subtest: basic-busy [54.878083] Starting dynamic subtest: rcs0 [54.913463] Dynamic subtest rcs0: SUCCESS (0.038s) [54.924463] Starting dynamic subtest: bcs0 [54.942586] Dynamic subtest bcs0: SUCCESS (0.029s) [54.953936] Starting dynamic subtest: vcs0 [54.967514] Dynamic subtest vcs0: SUCCESS (0.025s) [54.978469] Starting dynamic subtest: vecs0 [54.997509] Dynamic subtest vecs0: SUCCESS (0.030s) [54.998697] Subtest basic-busy: SUCCESS (0.123s) [55.716319] [022/165] (947s left) gem_exec_fence (basic-wait) [55.959572] Starting subtest: basic-wait [55.961236] Starting dynamic subtest: rcs0 [55.988845] Dynamic subtest rcs0: SUCCESS (0.029s) [55.999063] Starting dynamic subtest: bcs0 [56.021510] Dynamic subtest bcs0: SUCCESS (0.033s) [56.031713] Starting dynamic subtest: vcs0 [56.048423] Dynamic subtest vcs0: SUCCESS (0.027s) [56.058578] Starting dynamic subtest: vecs0 [56.077475] Dynamic subtest vecs0: SUCCESS (0.029s) [56.078717] Subtest basic-wait: SUCCESS (0.118s) [56.775258] [023/165] (946s left) gem_exec_fence (basic-await) [56.995494] Starting subtest: basic-await [56.997442] Starting dynamic subtest: rcs0 [57.103032] Dynamic subtest rcs0: SUCCESS (0.107s) [57.110417] Starting dynamic subtest: bcs0 [57.197950] Dynamic subtest bcs0: SUCCESS (0.094s) [57.206536] Starting dynamic subtest: vcs0 [57.296336] Dynamic subtest vcs0: SUCCESS (0.098s) [57.306213] Starting dynamic subtest: vecs0 [57.403369] Dynamic subtest vecs0: SUCCESS (0.104s) [57.404685] Subtest basic-await: SUCCESS (0.405s) [58.173287] [024/165] (945s left) gem_exec_fence (nb-await) [58.411724] Starting subtest: nb-await [58.414143] Starting dynamic subtest: rcs0 [58.482490] Dynamic subtest rcs0: SUCCESS (0.071s) [58.499448] Starting dynamic subtest: bcs0 [58.557986] Dynamic subtest bcs0: SUCCESS (0.072s) [58.596180] Starting dynamic subtest: vcs0 [58.652243] Dynamic subtest vcs0: SUCCESS (0.093s) [58.699187] Starting dynamic subtest: vecs0 [58.758290] Dynamic subtest vecs0: SUCCESS (0.104s) [58.762154] Subtest nb-await: SUCCESS (0.346s) [59.453024] [025/165] (943s left) gem_exec_gttfill (basic) [59.540263] Starting subtest: basic [68.940067] Subtest basic: SUCCESS (9.391s) [69.125948] [026/165] (934s left) gem_exec_parallel (engines) [69.273849] Starting subtest: engines [69.274791] Starting dynamic subtest: basic [71.598267] Dynamic subtest basic: SUCCESS (2.325s) [71.607324] Starting dynamic subtest: contexts [74.528654] Dynamic subtest contexts: SUCCESS (2.921s) [74.537132] Starting dynamic subtest: fds [82.202938] Dynamic subtest fds: SUCCESS (7.683s) [82.212216] Starting dynamic subtest: userptr [84.346810] Dynamic subtest userptr: SUCCESS (2.141s) [84.347711] Subtest engines: SUCCESS (15.071s) [84.587892] [027/165] (918s left) gem_exec_store (basic) [84.678993] Starting subtest: basic [84.726509] Subtest basic: SUCCESS (0.048s) [84.965929] [028/165] (918s left) gem_flink_basic (bad-flink) [85.043676] Starting subtest: bad-flink [85.044869] Subtest bad-flink: SUCCESS (0.000s) [85.118618] [029/165] (918s left) gem_flink_basic (bad-open) [85.192216] Starting subtest: bad-open [85.193393] Subtest bad-open: SUCCESS (0.000s) [85.270868] [030/165] (918s left) gem_flink_basic (basic) [85.347885] Starting subtest: basic [85.349075] Subtest basic: SUCCESS (0.000s) [85.441601] [031/165] (917s left) gem_flink_basic (double-flink) [85.524283] Starting subtest: double-flink [85.525376] Subtest double-flink: SUCCESS (0.000s) [85.598183] [032/165] (917s left) gem_flink_basic (flink-lifetime) [85.670706] Starting subtest: flink-lifetime [85.671816] Subtest flink-lifetime: SUCCESS (0.001s) [85.777104] [033/165] (917s left) gem_huc_copy (huc-copy) [85.868669] Starting subtest: huc-copy [85.870575] Subtest huc-copy: SKIP (0.000s) [85.996228] [034/165] (917s left) gem_linear_blits (basic) [86.228131] Starting subtest: basic [86.237043] Subtest basic: SUCCESS (0.009s) [86.397182] [035/165] (917s left) gem_mmap (basic) [86.523268] Starting subtest: basic [86.528365] Subtest basic: SUCCESS (0.001s) [86.597519] [036/165] (916s left) gem_mmap_gtt (basic) [86.669061] Starting subtest: basic [86.670185] Subtest basic: SUCCESS (0.001s) [86.732812] [037/165] (916s left) gem_render_linear_blits (basic) [86.810333] Starting subtest: basic [86.850896] Subtest basic: SUCCESS (0.039s) [86.899854] [038/165] (916s left) gem_render_tiled_blits (basic) [86.978473] Starting subtest: basic [87.029209] Subtest basic: SUCCESS (0.050s) [87.083125] [039/165] (916s left) gem_ringfill (basic-all) [87.342124] Starting subtest: basic-all [88.510597] Subtest basic-all: SUCCESS (1.160s) [88.615435] [040/165] (914s left) gem_softpin (allocator-basic) [88.710095] Starting subtest: allocator-basic [88.859644] Subtest allocator-basic: SUCCESS (0.141s) [88.980734] [041/165] (914s left) gem_softpin (allocator-basic-reserve) [89.065783] Starting subtest: allocator-basic-reserve [89.209822] Subtest allocator-basic-reserve: SUCCESS (0.136s) [89.331499] [042/165] (914s left) gem_softpin (safe-alignment) [89.420844] Starting subtest: safe-alignment [89.435895] Subtest safe-alignment: SUCCESS (0.015s) [89.567941] [043/165] (914s left) gem_sync (basic-all) [89.657525] Starting subtest: basic-all [91.953690] Subtest basic-all: SUCCESS (2.273s) [92.167473] [044/165] (911s left) gem_sync (basic-each) [92.254048] Starting subtest: basic-each [94.480516] Subtest basic-each: SUCCESS (2.227s) [94.811834] [045/165] (908s left) gem_tiled_blits (basic) [95.028842] Starting subtest: basic [95.052387] Subtest basic: SUCCESS (0.024s) [95.215945] [046/165] (908s left) gem_tiled_fence_blits (basic) [95.493236] Starting subtest: basic [95.506680] Subtest basic: SUCCESS (0.014s) [95.653423] [047/165] (908s left) gem_tiled_pread_basic [96.017285] [048/165] (907s left) gem_wait (busy@all-engines) [96.118339] Starting subtest: busy [96.119469] Starting dynamic subtest: all-engines [96.644153] Dynamic subtest all-engines: SUCCESS (0.526s) [96.645233] Subtest busy: SUCCESS (0.526s) [96.924688] [049/165] (906s left) gem_wait (wait@all-engines) [97.018775] Starting subtest: wait [97.019867] Starting dynamic subtest: all-engines [98.071299] Dynamic subtest all-engines: SUCCESS (1.053s) [98.072339] Subtest wait: SUCCESS (1.053s) [98.343227] [050/165] (905s left) i915_getparams_basic (basic-eu-total) [98.415626] Starting subtest: basic-eu-total [98.417710] Subtest basic-eu-total: SUCCESS (0.000s) [98.482465] [051/165] (905s left) i915_getparams_basic (basic-subslice-total) [98.554324] Starting subtest: basic-subslice-total [98.556432] Subtest basic-subslice-total: SUCCESS (0.000s) [98.615816] [052/165] (905s left) i915_hangman (error-state-basic) [98.699517] Starting subtest: error-state-basic [98.708107] Subtest error-state-basic: SUCCESS (0.007s) [98.781875] [053/165] (905s left) i915_pciid [98.917072] [054/165] (905s left) kms_addfb_basic (addfb25-4-tiled) [99.030121] Starting subtest: addfb25-4-tiled [99.031073] Subtest addfb25-4-tiled: SUCCESS (0.000s) [99.124744] [055/165] (904s left) kms_addfb_basic (addfb25-bad-modifier) [99.202455] Starting subtest: addfb25-bad-modifier [99.203508] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [99.338430] [056/165] (904s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [99.411840] Starting subtest: addfb25-framebuffer-vs-set-tiling [99.413050] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [99.558882] [057/165] (904s left) kms_addfb_basic (addfb25-modifier-no-flag) [99.630895] Starting subtest: addfb25-modifier-no-flag [99.632229] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [99.788957] [058/165] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy) [99.875149] Starting subtest: addfb25-x-tiled-legacy [99.876087] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [100.034101] [059/165] (904s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [100.121295] Starting subtest: addfb25-x-tiled-mismatch-legacy [100.122305] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [100.291600] [060/165] (903s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [100.414927] Starting subtest: addfb25-yf-tiled-legacy [100.416099] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [100.519205] [061/165] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy) [100.630301] Starting subtest: addfb25-y-tiled-legacy [100.631314] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [100.735026] [062/165] (903s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [100.858897] Starting subtest: addfb25-y-tiled-small-legacy [100.860025] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [100.972322] [063/165] (903s left) kms_addfb_basic (bad-pitch-0) [101.058366] Starting subtest: bad-pitch-0 [101.059309] Subtest bad-pitch-0: SUCCESS (0.000s) [101.219460] [064/165] (903s left) kms_addfb_basic (bad-pitch-1024) [101.308267] Starting subtest: bad-pitch-1024 [101.309168] Subtest bad-pitch-1024: SUCCESS (0.000s) [101.479272] [065/165] (902s left) kms_addfb_basic (bad-pitch-128) [101.552259] Starting subtest: bad-pitch-128 [101.553316] Subtest bad-pitch-128: SUCCESS (0.000s) [101.688193] [066/165] (902s left) kms_addfb_basic (bad-pitch-256) [101.764538] Starting subtest: bad-pitch-256 [101.765698] Subtest bad-pitch-256: SUCCESS (0.000s) [101.908177] [067/165] (902s left) kms_addfb_basic (bad-pitch-32) [101.984545] Starting subtest: bad-pitch-32 [101.985644] Subtest bad-pitch-32: SUCCESS (0.000s) [102.125817] [068/165] (902s left) kms_addfb_basic (bad-pitch-63) [102.202350] Starting subtest: bad-pitch-63 [102.203396] Subtest bad-pitch-63: SUCCESS (0.000s) [102.351983] [069/165] (902s left) kms_addfb_basic (bad-pitch-65536) [102.423350] Starting subtest: bad-pitch-65536 [102.424454] Subtest bad-pitch-65536: SUCCESS (0.000s) [102.568425] [070/165] (901s left) kms_addfb_basic (bad-pitch-999) [102.641052] Starting subtest: bad-pitch-999 [102.642103] Subtest bad-pitch-999: SUCCESS (0.000s) [102.801250] [071/165] (901s left) kms_addfb_basic (basic) [102.877466] Starting subtest: basic [102.878568] Subtest basic: SUCCESS (0.000s) [103.015229] [072/165] (901s left) kms_addfb_basic (basic-x-tiled-legacy) [103.088832] Starting subtest: basic-x-tiled-legacy [103.089916] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [103.226443] [073/165] (901s left) kms_addfb_basic (basic-y-tiled-legacy) [103.299465] Starting subtest: basic-y-tiled-legacy [103.300386] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [103.454852] [074/165] (901s left) kms_addfb_basic (bo-too-small) [103.573180] Starting subtest: bo-too-small [103.574119] Subtest bo-too-small: SUCCESS (0.000s) [103.676516] [075/165] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling) [103.798639] Starting subtest: bo-too-small-due-to-tiling [103.799773] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [103.894401] [076/165] (900s left) kms_addfb_basic (clobberred-modifier) [103.966916] Starting subtest: clobberred-modifier [103.968297] Subtest clobberred-modifier: SUCCESS (0.000s) [104.118500] [077/165] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling) [104.192192] Starting subtest: framebuffer-vs-set-tiling [104.193088] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.341836] [078/165] (900s left) kms_addfb_basic (invalid-get-prop) [104.413476] Starting subtest: invalid-get-prop [104.414418] Subtest invalid-get-prop: SUCCESS (0.000s) [104.555557] [079/165] (900s left) kms_addfb_basic (invalid-get-prop-any) [104.636036] Starting subtest: invalid-get-prop-any [104.636977] Subtest invalid-get-prop-any: SUCCESS (0.000s) [104.784709] [080/165] (899s left) kms_addfb_basic (invalid-set-prop) [104.868553] Starting subtest: invalid-set-prop [104.869653] Subtest invalid-set-prop: SUCCESS (0.000s) [105.014989] [081/165] (899s left) kms_addfb_basic (invalid-set-prop-any) [105.087451] Starting subtest: invalid-set-prop-any [105.088578] Subtest invalid-set-prop-any: SUCCESS (0.000s) [105.227377] [082/165] (899s left) kms_addfb_basic (no-handle) [105.300509] Starting subtest: no-handle [105.301626] Subtest no-handle: SUCCESS (0.000s) [105.435659] [083/165] (899s left) kms_addfb_basic (size-max) [105.554516] Starting subtest: size-max [105.555446] Subtest size-max: SUCCESS (0.000s) [105.649492] [084/165] (899s left) kms_addfb_basic (small-bo) [105.757528] Starting subtest: small-bo [105.758660] Subtest small-bo: SUCCESS (0.000s) [105.873717] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch) [105.945480] Starting subtest: tile-pitch-mismatch [105.946632] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.078038] [086/165] (898s left) kms_addfb_basic (too-high) [106.187785] Starting subtest: too-high [106.188928] Subtest too-high: SUCCESS (0.001s) [106.287388] [087/165] (898s left) kms_addfb_basic (too-wide) [106.399340] Starting subtest: too-wide [106.400434] Subtest too-wide: SUCCESS (0.000s) [106.497941] [088/165] (898s left) kms_addfb_basic (unused-handle) [106.576759] Starting subtest: unused-handle [106.577888] Subtest unused-handle: SUCCESS (0.000s) [106.740570] [089/165] (898s left) kms_addfb_basic (unused-modifier) [106.824515] Starting subtest: unused-modifier [106.825634] Subtest unused-modifier: SUCCESS (0.000s) [106.956588] [090/165] (897s left) kms_addfb_basic (unused-offsets) [107.031072] Starting subtest: unused-offsets [107.032176] Subtest unused-offsets: SUCCESS (0.000s) [107.169328] [091/165] (897s left) kms_addfb_basic (unused-pitches) [107.249219] Starting subtest: unused-pitches [107.250176] Subtest unused-pitches: SUCCESS (0.000s) [107.411733] [092/165] (897s left) kms_busy (basic) [107.530650] Starting subtest: basic [107.532633] Starting dynamic subtest: flip [108.531981] Dynamic subtest flip: SUCCESS (0.997s) [108.548782] Starting dynamic subtest: modeset [112.361127] Dynamic subtest modeset: SUCCESS (3.826s) [112.369311] Subtest basic: SUCCESS (4.827s) [113.288561] [093/165] (891s left) kms_prop_blob (basic) [113.374657] Starting subtest: basic [113.375722] Subtest basic: SUCCESS (0.000s) [113.437986] [094/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [113.547055] Starting subtest: basic-busy-flip-before-cursor-atomic [113.549073] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [113.661349] [095/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [113.784324] Starting subtest: basic-busy-flip-before-cursor-legacy [113.786329] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [113.869371] [096/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [113.985276] Starting subtest: basic-flip-after-cursor-atomic [115.272388] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.279s) [116.190581] [097/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.304470] Starting subtest: basic-flip-after-cursor-legacy [117.642505] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.332s) [118.519636] [098/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [118.630043] Starting subtest: basic-flip-after-cursor-varying-size [119.936248] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.305s) [120.852727] [099/165] (884s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [120.964202] Starting subtest: basic-flip-before-cursor-atomic [122.229258] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.265s) [123.119965] [100/165] (882s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [123.236152] Starting subtest: basic-flip-before-cursor-legacy [124.540388] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.302s) [125.494681] [101/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [125.605021] Starting subtest: basic-flip-before-cursor-varying-size [126.898334] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.288s) [127.805505] [102/165] (877s left) kms_dsc (dsc-basic) [127.916425] Subtest dsc-basic: SKIP (0.000s) [127.959631] [103/165] (877s left) kms_flip (basic-flip-vs-dpms) [128.051327] Starting subtest: basic-flip-vs-dpms [128.056162] Starting dynamic subtest: A-eDP1 [130.954472] Dynamic subtest A-eDP1: SUCCESS (2.895s) [131.001065] Starting dynamic subtest: B-eDP1 [133.302929] Dynamic subtest B-eDP1: SUCCESS (2.344s) [133.333121] Starting dynamic subtest: C-eDP1 [135.693816] Dynamic subtest C-eDP1: SUCCESS (2.380s) [135.709297] Subtest basic-flip-vs-dpms: SUCCESS (7.657s) [136.574995] [104/165] (868s left) kms_flip (basic-flip-vs-modeset) [136.670055] Starting subtest: basic-flip-vs-modeset [136.675285] Starting dynamic subtest: A-eDP1 [139.565191] Dynamic subtest A-eDP1: SUCCESS (2.882s) [139.623951] Starting dynamic subtest: B-eDP1 [141.921198] Dynamic subtest B-eDP1: SUCCESS (2.351s) [141.976520] Starting dynamic subtest: C-eDP1 [144.272148] Dynamic subtest C-eDP1: SUCCESS (2.337s) [144.285751] Subtest basic-flip-vs-modeset: SUCCESS (7.613s) [145.186933] [105/165] (860s left) kms_flip (basic-flip-vs-wf_vblank) [145.278833] Starting subtest: basic-flip-vs-wf_vblank [145.281928] Starting dynamic subtest: A-eDP1 [147.603665] Dynamic subtest A-eDP1: SUCCESS (2.321s) [147.616387] Starting dynamic subtest: B-eDP1 [149.906769] Dynamic subtest B-eDP1: SUCCESS (2.302s) [149.918755] Starting dynamic subtest: C-eDP1 [152.211190] Dynamic subtest C-eDP1: SUCCESS (2.302s) [152.215216] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.938s) [153.528018] [106/165] (851s left) kms_flip (basic-plain-flip) [153.618650] Starting subtest: basic-plain-flip [153.621495] Starting dynamic subtest: A-eDP1 [155.644111] Dynamic subtest A-eDP1: SUCCESS (2.016s) [155.717665] Starting dynamic subtest: B-eDP1 [157.721929] Dynamic subtest B-eDP1: SUCCESS (2.065s) [157.785931] Starting dynamic subtest: C-eDP1 [159.782573] Dynamic subtest C-eDP1: SUCCESS (2.054s) [159.807672] Subtest basic-plain-flip: SUCCESS (6.188s) [161.144815] [107/165] (844s left) kms_force_connector_basic (force-connector-state) [161.242733] Starting subtest: force-connector-state [161.761438] Subtest force-connector-state: SUCCESS (0.512s) [162.929569] [108/165] (842s left) kms_force_connector_basic (force-edid) [163.028082] Starting subtest: force-edid [163.059698] Subtest force-edid: SUCCESS (0.031s) [163.217986] [109/165] (842s left) kms_force_connector_basic (force-load-detect) [163.317957] Starting subtest: force-load-detect [163.320162] Subtest force-load-detect: SKIP (0.000s) [163.479864] [110/165] (841s left) kms_force_connector_basic (prune-stale-modes) [163.576355] Starting subtest: prune-stale-modes [163.608064] Subtest prune-stale-modes: SUCCESS (0.032s) [163.766948] [111/165] (841s left) kms_frontbuffer_tracking (basic) [163.884323] Starting subtest: basic [166.911968] Subtest basic: SUCCESS (3.028s) [167.055149] [112/165] (838s left) kms_hdmi_inject (inject-audio) [167.466226] Starting subtest: inject-audio [167.586432] Subtest inject-audio: SUCCESS (0.122s) [168.384176] [113/165] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [168.499070] Starting subtest: compare-crc-sanitycheck-xr24 [168.500157] Starting dynamic subtest: pipe-A-eDP-1 [169.185205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s) [169.223657] Starting dynamic subtest: pipe-B-eDP-1 [170.546786] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.349s) [170.608181] Starting dynamic subtest: pipe-C-eDP-1 [171.916077] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s) [171.921033] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.411s) [172.795401] [114/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [172.906709] Starting subtest: compare-crc-sanitycheck-nv12 [172.907763] Starting dynamic subtest: pipe-A-eDP-1 [172.909814] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [172.922960] Starting dynamic subtest: pipe-B-eDP-1 [172.924942] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [172.936336] Starting dynamic subtest: pipe-C-eDP-1 [172.938320] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [172.940293] Subtest compare-crc-sanitycheck-nv12: SKIP (0.009s) [172.998605] [115/165] (832s left) kms_pipe_crc_basic (hang-read-crc) [173.113716] Starting subtest: hang-read-crc [173.116143] Starting dynamic subtest: pipe-A-eDP-1 [175.711372] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.584s) [175.781856] Starting dynamic subtest: pipe-B-eDP-1 [179.097407] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.375s) [179.163666] Starting dynamic subtest: pipe-C-eDP-1 [182.282533] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.158s) [182.286679] Subtest hang-read-crc: SUCCESS (9.165s) [183.161349] [116/165] (822s left) kms_pipe_crc_basic (nonblocking-crc) [183.280993] Starting subtest: nonblocking-crc [183.282074] Starting dynamic subtest: pipe-A-eDP-1 [184.272351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.984s) [184.346356] Starting dynamic subtest: pipe-B-eDP-1 [186.065693] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.774s) [186.143505] Starting dynamic subtest: pipe-C-eDP-1 [187.846984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.760s) [187.850297] Subtest nonblocking-crc: SUCCESS (4.566s) [188.793897] [117/165] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [188.921771] Starting subtest: nonblocking-crc-frame-sequence [188.924375] Starting dynamic subtest: pipe-A-eDP-1 [189.956782] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.025s) [190.023883] Starting dynamic subtest: pipe-B-eDP-1 [191.751402] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.766s) [191.827698] Starting dynamic subtest: pipe-C-eDP-1 [193.400906] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.631s) [193.405287] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.479s) [194.283139] [118/165] (811s left) kms_pipe_crc_basic (read-crc) [194.407265] Starting subtest: read-crc [194.410201] Starting dynamic subtest: pipe-A-eDP-1 [195.258662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.845s) [195.321844] Starting dynamic subtest: pipe-B-eDP-1 [196.866189] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.584s) [196.945668] Starting dynamic subtest: pipe-C-eDP-1 [198.513116] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.628s) [198.517257] Subtest read-crc: SUCCESS (4.108s) [199.434956] [119/165] (806s left) kms_pipe_crc_basic (read-crc-frame-sequence) [199.545323] Starting subtest: read-crc-frame-sequence [199.546460] Starting dynamic subtest: pipe-A-eDP-1 [200.380595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s) [200.442458] Starting dynamic subtest: pipe-B-eDP-1 [202.034684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.640s) [202.112633] Starting dynamic subtest: pipe-C-eDP-1 [203.697480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.640s) [203.700922] Subtest read-crc-frame-sequence: SUCCESS (4.149s) [204.637583] [120/165] (801s left) kms_pm_backlight (basic-brightness) [204.748480] Starting subtest: basic-brightness [204.846837] Starting dynamic subtest: eDP-1 [205.496215] Dynamic subtest eDP-1: SUCCESS (0.645s) [205.500660] Subtest basic-brightness: SUCCESS (0.751s) [206.401324] [121/165] (799s left) kms_pm_rpm (basic-pci-d3-state) [208.142419] Starting subtest: basic-pci-d3-state [212.643764] Subtest basic-pci-d3-state: SUCCESS (4.503s) [212.803034] [122/165] (792s left) kms_pm_rpm (basic-rte) [212.877718] Starting subtest: basic-rte [219.043425] Subtest basic-rte: SUCCESS (6.164s) [220.674820] [123/165] (785s left) kms_psr (psr_primary_page_flip) [220.789396] Starting subtest: psr_primary_page_flip [220.790467] Starting dynamic subtest: eDP-1 [222.879078] Dynamic subtest eDP-1: SUCCESS (2.079s) [222.882837] Subtest psr_primary_page_flip: SUCCESS (2.088s) [223.788833] [124/165] (782s left) kms_psr (psr_cursor_plane_move) [223.902213] Starting subtest: psr_cursor_plane_move [223.903268] Starting dynamic subtest: eDP-1 [225.958366] Dynamic subtest eDP-1: SUCCESS (2.050s) [225.974470] Subtest psr_cursor_plane_move: SUCCESS (2.059s) [226.899182] [125/165] (778s left) kms_psr (psr_sprite_plane_onoff) [227.026349] Starting subtest: psr_sprite_plane_onoff [227.027433] Starting dynamic subtest: eDP-1 [229.134892] Dynamic subtest eDP-1: SUCCESS (2.099s) [229.140104] Subtest psr_sprite_plane_onoff: SUCCESS (2.109s) [230.061188] [126/165] (775s left) kms_psr (psr_primary_mmap_gtt) [230.180162] Starting subtest: psr_primary_mmap_gtt [230.181172] Starting dynamic subtest: eDP-1 [232.330454] Dynamic subtest eDP-1: SUCCESS (2.137s) [232.334463] Subtest psr_primary_mmap_gtt: SUCCESS (2.149s) [233.270264] [127/165] (772s left) kms_setmode (basic-clone-single-crtc) [233.345252] Starting subtest: basic-clone-single-crtc [233.348169] Subtest basic-clone-single-crtc: SKIP (0.001s) [233.454787] [128/165] (772s left) i915_pm_rps (basic-api) [233.541022] Starting subtest: basic-api [233.545822] Subtest basic-api: SUCCESS (0.005s) [233.666865] [129/165] (772s left) prime_self_import (basic-llseek-bad) [233.744112] Starting subtest: basic-llseek-bad [233.746341] Subtest basic-llseek-bad: SUCCESS (0.002s) [233.868760] [130/165] (772s left) prime_self_import (basic-llseek-size) [233.950315] Starting subtest: basic-llseek-size [233.952439] Subtest basic-llseek-size: SUCCESS (0.003s) [234.086817] [131/165] (771s left) prime_self_import (basic-with_fd_dup) [234.156144] Starting subtest: basic-with_fd_dup [234.160792] Subtest basic-with_fd_dup: SUCCESS (0.003s) [234.292420] [132/165] (771s left) prime_self_import (basic-with_one_bo) [234.370235] Starting subtest: basic-with_one_bo [234.374837] Subtest basic-with_one_bo: SUCCESS (0.004s) [234.478606] [133/165] (771s left) prime_self_import (basic-with_one_bo_two_files) [234.555320] Starting subtest: basic-with_one_bo_two_files [234.560288] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [234.640943] [134/165] (771s left) prime_self_import (basic-with_two_bos) [234.715531] Starting subtest: basic-with_two_bos [234.719520] Subtest basic-with_two_bos: SUCCESS (0.004s) [234.807048] [135/165] (771s left) prime_vgem (basic-fence-flip) [234.908796] Starting subtest: basic-fence-flip [235.377913] Subtest basic-fence-flip: SUCCESS (0.469s) [235.489655] [136/165] (770s left) prime_vgem (basic-fence-mmap) [235.570331] Starting subtest: basic-fence-mmap [235.608447] Subtest basic-fence-mmap: SUCCESS (0.038s) [235.700889] [137/165] (770s left) prime_vgem (basic-fence-read) [235.802174] Starting subtest: basic-fence-read [235.861186] Subtest basic-fence-read: SUCCESS (0.059s) [235.946391] [138/165] (770s left) prime_vgem (basic-gtt) [236.035566] Starting subtest: basic-gtt [236.052537] Subtest basic-gtt: SUCCESS (0.017s) [236.145293] [139/165] (770s left) prime_vgem (basic-read) [236.235148] Starting subtest: basic-read [236.261407] Subtest basic-read: SUCCESS (0.026s) [236.341365] [140/165] (769s left) prime_vgem (basic-write) [236.437362] Starting subtest: basic-write [236.466682] Subtest basic-write: SUCCESS (0.029s) [236.544314] [141/165] (769s left) vgem_basic (setversion) [236.629379] Starting subtest: setversion [236.631491] Subtest setversion: SUCCESS (0.000s) [236.688803] [142/165] (769s left) vgem_basic (create) [236.762576] Starting subtest: create [236.763697] Subtest create: SUCCESS (0.000s) [236.824854] [143/165] (769s left) vgem_basic (debugfs) [236.913167] Starting subtest: debugfs [236.914354] Subtest debugfs: SUCCESS (0.000s) [236.972313] [144/165] (769s left) vgem_basic (dmabuf-export) [237.046386] Starting subtest: dmabuf-export [237.048641] Subtest dmabuf-export: SUCCESS (0.002s) [237.156391] [145/165] (769s left) vgem_basic (dmabuf-fence) [237.229463] Starting subtest: dmabuf-fence [237.230519] Subtest dmabuf-fence: SUCCESS (0.001s) [237.288549] [146/165] (769s left) vgem_basic (dmabuf-fence-before) [237.362886] Starting subtest: dmabuf-fence-before [237.364081] Subtest dmabuf-fence-before: SUCCESS (0.001s) [237.425327] [147/165] (769s left) vgem_basic (dmabuf-mmap) [237.512741] Starting subtest: dmabuf-mmap [237.529620] Subtest dmabuf-mmap: SUCCESS (0.017s) [237.589406] [148/165] (768s left) vgem_basic (mmap) [237.662566] Starting subtest: mmap [237.675112] Subtest mmap: SUCCESS (0.012s) [237.744523] [149/165] (768s left) vgem_basic (second-client) [237.829610] Starting subtest: second-client [237.863089] Subtest second-client: SUCCESS (0.033s) [237.933716] [150/165] (768s left) vgem_basic (sysfs) [238.029744] Starting subtest: sysfs [238.030921] Subtest sysfs: SUCCESS (0.001s) [238.089652] [151/165] (768s left) core_hotunplug (unbind-rebind) [238.196435] Starting subtest: unbind-rebind [242.533930] Subtest unbind-rebind: SUCCESS (4.335s) [242.590565] [152/165] (764s left) vgem_basic (unload) [242.683141] Starting subtest: unload [271.783130] Subtest unload: SUCCESS (29.064s) [271.885207] [153/165] (734s left) i915_module_load (reload) [271.957259] Starting subtest: reload [275.151328] Subtest reload: SUCCESS (3.194s) [275.179526] [154/165] (731s left) gem_lmem_swapping (basic) [275.288095] Subtest basic: SKIP (0.000s) [275.338927] [155/165] (731s left) gem_lmem_swapping (parallel-random-engines) [275.424943] Subtest parallel-random-engines: SKIP (0.000s) [275.464359] [156/165] (731s left) gem_lmem_swapping (random-engines) [275.543158] Subtest random-engines: SKIP (0.000s) [275.581034] [157/165] (731s left) gem_lmem_swapping (verify-random) [275.659958] Subtest verify-random: SKIP (0.000s) [275.697335] [158/165] (731s left) i915_pm_rpm (module-reload) [278.461369] Starting subtest: module-reload [290.435124] Subtest module-reload: SUCCESS (11.980s) [290.452551] [159/165] (716s left) i915_selftest (live) [290.544384] Starting subtest: live [290.545536] Starting dynamic subtest: sanitycheck [292.257769] Dynamic subtest sanitycheck: SUCCESS (1.704s) [292.266143] Starting dynamic subtest: uncore [293.972775] Dynamic subtest uncore: SUCCESS (1.713s) [293.981094] Starting dynamic subtest: workarounds [295.878623] Dynamic subtest workarounds: SUCCESS (1.904s) [295.885835] Starting dynamic subtest: gt_engines [298.035719] Dynamic subtest gt_engines: SUCCESS (2.155s) [298.047543] Starting dynamic subtest: gt_timelines [309.050470] Dynamic subtest gt_timelines: SUCCESS (11.012s) [309.062859] Starting dynamic subtest: gt_contexts [310.856767] Dynamic subtest gt_contexts: SUCCESS (1.804s) [310.868944] Starting dynamic subtest: gt_lrc [315.054790] Dynamic subtest gt_lrc: SUCCESS (4.196s) [315.064039] Starting dynamic subtest: gt_mocs [316.865038] Dynamic subtest gt_mocs: SUCCESS (1.808s) [316.879388] Starting dynamic subtest: gt_pm [322.958559] Dynamic subtest gt_pm: SUCCESS (6.090s) [322.978519] Starting dynamic subtest: gt_heartbeat [324.766738] Dynamic subtest gt_heartbeat: SUCCESS (1.804s) [324.775105] Starting dynamic subtest: gt_tlb [327.402979] Dynamic subtest gt_tlb: SUCCESS (2.634s) [327.412479] Starting dynamic subtest: requests [334.838793] Dynamic subtest requests: SUCCESS (7.434s) [334.846560] Starting dynamic subtest: migrate [339.344738] Dynamic subtest migrate: SUCCESS (4.504s) [339.352590] Starting dynamic subtest: active [341.081791] Dynamic subtest active: SUCCESS (1.735s) [341.091270] Starting dynamic subtest: objects [343.919744] Dynamic subtest objects: SUCCESS (2.836s) [343.930186] Starting dynamic subtest: mman [349.050735] Dynamic subtest mman: SUCCESS (5.129s) [349.058490] Starting dynamic subtest: dmabuf [350.815795] Dynamic subtest dmabuf: SUCCESS (1.763s) [350.824293] Starting dynamic subtest: vma [352.540674] Dynamic subtest vma: SUCCESS (1.723s) [352.548343] Starting dynamic subtest: coherency [356.130596] Dynamic subtest coherency: SUCCESS (3.588s) [356.141031] Starting dynamic subtest: gtt [364.636894] Dynamic subtest gtt: SUCCESS (8.504s) [364.645453] Starting dynamic subtest: gem [366.533860] Dynamic subtest gem: SUCCESS (1.895s) [366.543380] Starting dynamic subtest: evict [369.783973] Dynamic subtest evict: SUCCESS (3.248s) [369.794283] Starting dynamic subtest: hugepages [376.776756] Dynamic subtest hugepages: SUCCESS (6.991s) [376.785252] Starting dynamic subtest: gem_contexts [391.124754] Dynamic subtest gem_contexts: SUCCESS (14.346s) [391.132517] Starting dynamic subtest: client [392.858769] Dynamic subtest client: SUCCESS (1.733s) [392.867357] Starting dynamic subtest: gem_migrate [394.648789] Dynamic subtest gem_migrate: SUCCESS (1.788s) [394.660392] Starting dynamic subtest: reset [397.116061] Dynamic subtest reset: SUCCESS (2.465s) [397.130571] Starting dynamic subtest: memory_region [398.799730] Dynamic subtest memory_region: SUCCESS (1.682s) [398.810345] Starting dynamic subtest: hangcheck [422.968676] Dynamic subtest hangcheck: SUCCESS (24.167s) [422.979289] Starting dynamic subtest: execlists [432.622865] Dynamic subtest execlists: SUCCESS (9.652s) [432.630661] Starting dynamic subtest: ring_submission [434.336309] Dynamic subtest ring_submission: SUCCESS (1.712s) [434.347280] Starting dynamic subtest: perf [436.221309] Dynamic subtest perf: SUCCESS (1.883s) [436.234080] Starting dynamic subtest: slpc [437.965691] Dynamic subtest slpc: SUCCESS (1.742s) [437.976380] Starting dynamic subtest: guc [439.750770] Dynamic subtest guc: SUCCESS (1.783s) [439.759234] Starting dynamic subtest: guc_multi_lrc [441.501913] Dynamic subtest guc_multi_lrc: SUCCESS (1.749s) [441.514114] Starting dynamic subtest: guc_hang [443.229701] Dynamic subtest guc_hang: SUCCESS (1.726s) [443.237416] Starting dynamic subtest: late_gt_pm [445.081891] Dynamic subtest late_gt_pm: SUCCESS (1.851s) [445.083078] Subtest live: SUCCESS (154.530s) [445.105166] [160/165] (561s left) dmabuf (all-tests) [445.186231] Starting subtest: all-tests [445.187734] Starting dynamic subtest: sanitycheck [445.252108] Dynamic subtest sanitycheck: SUCCESS (0.064s) [445.275625] Starting dynamic subtest: dma_fence [445.441527] Dynamic subtest dma_fence: SUCCESS (0.185s) [445.455721] Starting dynamic subtest: dma_fence_chain [461.508951] Dynamic subtest dma_fence_chain: SUCCESS (16.054s) [461.536706] Starting dynamic subtest: dma_fence_unwrap [461.590492] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [461.625520] Starting dynamic subtest: dma_resv [461.677703] Dynamic subtest dma_resv: SUCCESS (0.080s) [461.679279] Subtest all-tests: SUCCESS (16.493s) [461.715499] [161/165] (545s left) i915_suspend (basic-s2idle-without-i915) [461.800624] Starting subtest: basic-s2idle-without-i915 [481.741851] Subtest basic-s2idle-without-i915: SUCCESS (4.549s) [484.865445] [162/165] (540s left) i915_suspend (basic-s3-without-i915) [484.957493] Starting subtest: basic-s3-without-i915 [505.455615] Subtest basic-s3-without-i915: SUCCESS (4.278s) [508.565274] [163/165] (535s left) gem_exec_suspend (basic-s0) [508.687092] Starting subtest: basic-S0 [508.688171] Starting dynamic subtest: smem [527.415622] Dynamic subtest smem: SUCCESS (3.293s) [527.416990] Subtest basic-S0: SUCCESS (3.295s) [530.643876] [164/165] (532s left) gem_exec_suspend (basic-s3) [530.761671] Starting subtest: basic-S3 [530.762876] Starting dynamic subtest: smem [551.735801] Dynamic subtest smem: SUCCESS (4.650s) [551.736690] Subtest basic-S3: SUCCESS (4.652s) [554.029337] [165/165] (527s left) kms_pipe_crc_basic (suspend-read-crc) [554.152921] Starting subtest: suspend-read-crc [554.153994] Starting dynamic subtest: pipe-A-eDP-1 [574.930924] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.037s) [574.975063] Starting dynamic subtest: pipe-B-eDP-1 [595.749444] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.471s) [595.774203] Starting dynamic subtest: pipe-C-eDP-1 [616.840001] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.557s) [616.843170] Subtest suspend-read-crc: SUCCESS (13.094s) [619.712899] Closing watchdogs Done.