[43.688132] Initializing watchdogs [43.688344] /dev/watchdog0 [43.700374] [001/165] (960s left) i915_module_load (load) [43.772723] Starting subtest: load [46.039411] Subtest load: SUCCESS (2.265s) [46.058181] [002/165] (958s left) core_auth (basic-auth) [46.137710] Starting subtest: basic-auth [46.141043] Subtest basic-auth: SUCCESS (0.001s) [46.218462] [003/165] (958s left) debugfs_test (read_all_entries) [46.327499] Starting subtest: read_all_entries [46.469908] Subtest read_all_entries: SUCCESS (0.140s) [46.756264] [004/165] (957s left) debugfs_test (basic-hwmon) [46.837145] Starting subtest: basic-hwmon [46.845292] Subtest basic-hwmon: SKIP (0.000s) [47.141908] [005/165] (957s left) fbdev (eof) [47.248325] Starting subtest: eof [47.251592] Subtest eof: SUCCESS (0.001s) [47.300067] [006/165] (957s left) fbdev (info) [47.364713] Starting subtest: info [47.367652] Subtest info: SUCCESS (0.000s) [47.435913] [007/165] (956s left) fbdev (nullptr) [47.522964] Starting subtest: nullptr [47.526237] Subtest nullptr: SUCCESS (0.000s) [47.586617] [008/165] (956s left) fbdev (read) [47.691327] Starting subtest: read [47.980819] Subtest read: SUCCESS (0.257s) [48.272310] [009/165] (956s left) fbdev (write) [48.598978] Starting subtest: write [48.730341] Subtest write: SUCCESS (0.157s) [49.025860] [010/165] (955s left) gem_basic (bad-close) [49.259807] Starting subtest: bad-close [49.268826] Subtest bad-close: SUCCESS (0.000s) [49.347389] [011/165] (955s left) gem_basic (create-close) [49.444277] Starting subtest: create-close [49.450900] Subtest create-close: SUCCESS (0.000s) [49.541555] [012/165] (955s left) gem_basic (create-fd-close) [49.607176] Starting subtest: create-fd-close [49.614568] Subtest create-fd-close: SUCCESS (0.000s) [49.714220] [013/165] (955s left) gem_busy (busy@all-engines) [49.816973] Starting subtest: busy [49.820655] Starting dynamic subtest: all-engines [49.894537] Dynamic subtest all-engines: SUCCESS (0.078s) [49.897915] Subtest busy: SUCCESS (0.078s) [50.289832] [014/165] (954s left) gem_close_race (basic-process) [50.391879] Starting subtest: basic-process [50.459843] Subtest basic-process: SUCCESS (0.067s) [50.682657] [015/165] (954s left) gem_close_race (basic-threads) [50.798138] Starting subtest: basic-threads [51.988778] Subtest basic-threads: SUCCESS (1.190s) [52.195409] [016/165] (952s left) gem_ctx_create (basic) [52.277363] Starting subtest: basic [52.280634] Subtest basic: SUCCESS (0.000s) [52.480903] [017/165] (952s left) gem_ctx_create (basic-files) [52.558797] Starting subtest: basic-files [54.576084] Subtest basic-files: SUCCESS (2.017s) [54.820901] [018/165] (950s left) gem_ctx_exec (basic) [54.893945] Starting subtest: basic [54.897102] Subtest basic: SUCCESS (0.004s) [55.013944] [019/165] (950s left) gem_exec_basic (basic) [55.099381] Starting subtest: basic [55.102555] Starting dynamic subtest: rcs0-smem [55.105907] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.113925] Starting dynamic subtest: bcs0-smem [55.117336] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [55.125039] Starting dynamic subtest: vcs0-smem [55.128634] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.136760] Starting dynamic subtest: vcs1-smem [55.140244] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [55.148358] Starting dynamic subtest: vecs0-smem [55.151152] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [55.154071] Subtest basic: SUCCESS (0.005s) [55.332402] [020/165] (949s left) gem_exec_create (basic) [55.431999] Starting subtest: basic [55.435517] Starting dynamic subtest: smem [57.478248] Dynamic subtest smem: SUCCESS (2.046s) [57.481578] Subtest basic: SUCCESS (2.047s) [57.695955] [021/165] (947s left) gem_exec_fence (basic-busy) [57.927463] Starting subtest: basic-busy [57.931659] Starting dynamic subtest: rcs0 [57.960863] Dynamic subtest rcs0: SUCCESS (0.034s) [57.973880] Starting dynamic subtest: bcs0 [57.989941] Dynamic subtest bcs0: SUCCESS (0.029s) [58.005191] Starting dynamic subtest: vcs0 [58.020040] Dynamic subtest vcs0: SUCCESS (0.029s) [58.030092] Starting dynamic subtest: vcs1 [58.057620] Dynamic subtest vcs1: SUCCESS (0.036s) [58.072763] Starting dynamic subtest: vecs0 [58.089371] Dynamic subtest vecs0: SUCCESS (0.034s) [58.092572] Subtest basic-busy: SUCCESS (0.164s) [58.762102] [022/165] (946s left) gem_exec_fence (basic-wait) [58.994494] Starting subtest: basic-wait [58.997970] Starting dynamic subtest: rcs0 [59.018888] Dynamic subtest rcs0: SUCCESS (0.026s) [59.033771] Starting dynamic subtest: bcs0 [59.043252] Dynamic subtest bcs0: SUCCESS (0.023s) [59.055037] Starting dynamic subtest: vcs0 [59.070285] Dynamic subtest vcs0: SUCCESS (0.027s) [59.080055] Starting dynamic subtest: vcs1 [59.092280] Dynamic subtest vcs1: SUCCESS (0.022s) [59.102199] Starting dynamic subtest: vecs0 [59.113886] Dynamic subtest vecs0: SUCCESS (0.022s) [59.117037] Subtest basic-wait: SUCCESS (0.120s) [59.731228] [023/165] (945s left) gem_exec_fence (basic-await) [59.947911] Starting subtest: basic-await [59.952044] Starting dynamic subtest: rcs0 [60.060207] Dynamic subtest rcs0: SUCCESS (0.116s) [60.072251] Starting dynamic subtest: bcs0 [60.158451] Dynamic subtest bcs0: SUCCESS (0.098s) [60.171277] Starting dynamic subtest: vcs0 [60.266071] Dynamic subtest vcs0: SUCCESS (0.107s) [60.276474] Starting dynamic subtest: vcs1 [60.374328] Dynamic subtest vcs1: SUCCESS (0.108s) [60.384453] Starting dynamic subtest: vecs0 [60.476163] Dynamic subtest vecs0: SUCCESS (0.101s) [60.479436] Subtest basic-await: SUCCESS (0.532s) [61.131123] [024/165] (944s left) gem_exec_fence (nb-await) [61.363221] Starting subtest: nb-await [61.367158] Starting dynamic subtest: rcs0 [61.443340] Dynamic subtest rcs0: SUCCESS (0.079s) [61.459643] Starting dynamic subtest: bcs0 [61.522730] Dynamic subtest bcs0: SUCCESS (0.076s) [61.548968] Starting dynamic subtest: vcs0 [61.605180] Dynamic subtest vcs0: SUCCESS (0.082s) [61.614777] Starting dynamic subtest: vcs1 [61.665246] Dynamic subtest vcs1: SUCCESS (0.060s) [61.674711] Starting dynamic subtest: vecs0 [61.724308] Dynamic subtest vecs0: SUCCESS (0.059s) [61.727445] Subtest nb-await: SUCCESS (0.362s) [62.318962] [025/165] (943s left) gem_exec_gttfill (basic) [62.418882] Starting subtest: basic [66.986412] Subtest basic: SUCCESS (4.567s) [67.188349] [026/165] (938s left) gem_exec_parallel (engines) [67.355312] Starting subtest: engines [67.359655] Starting dynamic subtest: basic [69.343907] Dynamic subtest basic: SUCCESS (1.990s) [69.353145] Starting dynamic subtest: contexts [72.053282] Dynamic subtest contexts: SUCCESS (2.709s) [72.062876] Starting dynamic subtest: fds [76.310540] Dynamic subtest fds: SUCCESS (4.257s) [76.329936] Starting dynamic subtest: userptr [78.466478] Dynamic subtest userptr: SUCCESS (2.156s) [78.470217] Subtest engines: SUCCESS (11.112s) [78.669473] [027/165] (926s left) gem_exec_store (basic) [78.777817] Starting subtest: basic [78.827064] Subtest basic: SUCCESS (0.052s) [79.038294] [028/165] (926s left) gem_flink_basic (bad-flink) [79.111444] Starting subtest: bad-flink [79.114915] Subtest bad-flink: SUCCESS (0.000s) [79.192135] [029/165] (926s left) gem_flink_basic (bad-open) [79.275198] Starting subtest: bad-open [79.278353] Subtest bad-open: SUCCESS (0.000s) [79.341375] [030/165] (926s left) gem_flink_basic (basic) [79.410910] Starting subtest: basic [79.414613] Subtest basic: SUCCESS (0.000s) [79.511255] [031/165] (926s left) gem_flink_basic (double-flink) [79.605113] Starting subtest: double-flink [79.609260] Subtest double-flink: SUCCESS (0.000s) [79.711152] [032/165] (925s left) gem_flink_basic (flink-lifetime) [79.801662] Starting subtest: flink-lifetime [79.805181] Subtest flink-lifetime: SUCCESS (0.002s) [79.912869] [033/165] (925s left) gem_huc_copy (huc-copy) [80.005408] Starting subtest: huc-copy [80.012204] Subtest huc-copy: SKIP (0.000s) [80.123127] [034/165] (925s left) gem_linear_blits (basic) [80.299804] Starting subtest: basic [80.309973] Subtest basic: SUCCESS (0.008s) [80.458791] [035/165] (925s left) gem_mmap (basic) [80.630249] Starting subtest: basic [80.647118] Subtest basic: SUCCESS (0.000s) [80.704426] [036/165] (925s left) gem_mmap_gtt (basic) [80.780274] Starting subtest: basic [80.783494] Subtest basic: SUCCESS (0.001s) [80.859519] [037/165] (924s left) gem_render_linear_blits (basic) [80.953701] Starting subtest: basic [80.982859] Subtest basic: SUCCESS (0.031s) [81.034028] [038/165] (924s left) gem_render_tiled_blits (basic) [81.106533] Starting subtest: basic [81.140113] Subtest basic: SUCCESS (0.034s) [81.192372] [039/165] (924s left) gem_ringfill (basic-all) [81.484317] Starting subtest: basic-all [82.668358] Subtest basic-all: SUCCESS (1.179s) [82.790440] [040/165] (923s left) gem_softpin (allocator-basic) [82.888341] Starting subtest: allocator-basic [82.997025] Subtest allocator-basic: SUCCESS (0.108s) [83.106347] [041/165] (922s left) gem_softpin (allocator-basic-reserve) [83.194862] Starting subtest: allocator-basic-reserve [83.302648] Subtest allocator-basic-reserve: SUCCESS (0.106s) [83.394902] [042/165] (922s left) gem_softpin (safe-alignment) [83.480080] Starting subtest: safe-alignment [83.498825] Subtest safe-alignment: SUCCESS (0.019s) [83.613473] [043/165] (922s left) gem_sync (basic-all) [83.726225] Starting subtest: basic-all [85.935239] Subtest basic-all: SUCCESS (2.228s) [86.147665] [044/165] (919s left) gem_sync (basic-each) [86.261769] Starting subtest: basic-each [88.377663] Subtest basic-each: SUCCESS (2.134s) [88.580427] [045/165] (917s left) gem_tiled_blits (basic) [88.789183] Starting subtest: basic [88.807940] Subtest basic: SUCCESS (0.019s) [88.954537] [046/165] (917s left) gem_tiled_fence_blits (basic) [89.265146] Starting subtest: basic [89.276892] Subtest basic: SUCCESS (0.010s) [89.432346] [047/165] (916s left) gem_tiled_pread_basic [89.819831] [048/165] (916s left) gem_wait (busy@all-engines) [89.920211] Starting subtest: busy [89.923483] Starting dynamic subtest: all-engines [90.448261] Dynamic subtest all-engines: SUCCESS (0.528s) [90.451401] Subtest busy: SUCCESS (0.528s) [90.686690] [049/165] (915s left) gem_wait (wait@all-engines) [90.764910] Starting subtest: wait [90.768180] Starting dynamic subtest: all-engines [91.809272] Dynamic subtest all-engines: SUCCESS (1.043s) [91.813123] Subtest wait: SUCCESS (1.044s) [92.056633] [050/165] (914s left) i915_getparams_basic (basic-eu-total) [92.145119] Starting subtest: basic-eu-total [92.151559] Subtest basic-eu-total: SUCCESS (0.000s) [92.217505] [051/165] (914s left) i915_getparams_basic (basic-subslice-total) [92.299938] Starting subtest: basic-subslice-total [92.306475] Subtest basic-subslice-total: SUCCESS (0.000s) [92.375655] [052/165] (913s left) i915_hangman (error-state-basic) [92.463413] Starting subtest: error-state-basic [92.473112] Subtest error-state-basic: SUCCESS (0.006s) [92.542312] [053/165] (913s left) i915_pciid [92.692346] [054/165] (913s left) kms_addfb_basic (addfb25-4-tiled) [93.003312] Starting subtest: addfb25-4-tiled [93.006724] Subtest addfb25-4-tiled: SUCCESS (0.000s) [93.113254] [055/165] (913s left) kms_addfb_basic (addfb25-bad-modifier) [93.202183] Starting subtest: addfb25-bad-modifier [93.205448] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [93.495689] [056/165] (912s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [93.574510] Starting subtest: addfb25-framebuffer-vs-set-tiling [93.577712] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [93.873678] [057/165] (912s left) kms_addfb_basic (addfb25-modifier-no-flag) [93.958331] Starting subtest: addfb25-modifier-no-flag [93.961523] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [94.250572] [058/165] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy) [94.319623] Starting subtest: addfb25-x-tiled-legacy [94.322510] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [94.601866] [059/165] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [94.676084] Starting subtest: addfb25-x-tiled-mismatch-legacy [94.681266] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [94.978997] [060/165] (911s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [95.312831] Starting subtest: addfb25-yf-tiled-legacy [95.316614] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [95.392344] [061/165] (911s left) kms_addfb_basic (addfb25-y-tiled-legacy) [95.675898] Starting subtest: addfb25-y-tiled-legacy [95.678667] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [95.749641] [062/165] (910s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [96.023716] Starting subtest: addfb25-y-tiled-small-legacy [96.026396] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [96.112942] [063/165] (910s left) kms_addfb_basic (bad-pitch-0) [96.195083] Starting subtest: bad-pitch-0 [96.198378] Subtest bad-pitch-0: SUCCESS (0.000s) [96.491648] [064/165] (910s left) kms_addfb_basic (bad-pitch-1024) [96.564389] Starting subtest: bad-pitch-1024 [96.567543] Subtest bad-pitch-1024: SUCCESS (0.000s) [96.864252] [065/165] (909s left) kms_addfb_basic (bad-pitch-128) [96.945645] Starting subtest: bad-pitch-128 [96.948978] Subtest bad-pitch-128: SUCCESS (0.000s) [97.239254] [066/165] (909s left) kms_addfb_basic (bad-pitch-256) [97.325573] Starting subtest: bad-pitch-256 [97.328767] Subtest bad-pitch-256: SUCCESS (0.000s) [97.620245] [067/165] (909s left) kms_addfb_basic (bad-pitch-32) [97.699714] Starting subtest: bad-pitch-32 [97.702874] Subtest bad-pitch-32: SUCCESS (0.000s) [97.984820] [068/165] (908s left) kms_addfb_basic (bad-pitch-63) [98.056094] Starting subtest: bad-pitch-63 [98.059384] Subtest bad-pitch-63: SUCCESS (0.000s) [98.360105] [069/165] (908s left) kms_addfb_basic (bad-pitch-65536) [98.460781] Starting subtest: bad-pitch-65536 [98.464532] Subtest bad-pitch-65536: SUCCESS (0.001s) [98.757180] [070/165] (908s left) kms_addfb_basic (bad-pitch-999) [98.853116] Starting subtest: bad-pitch-999 [98.855929] Subtest bad-pitch-999: SUCCESS (0.000s) [99.141233] [071/165] (907s left) kms_addfb_basic (basic) [99.211569] Starting subtest: basic [99.214404] Subtest basic: SUCCESS (0.000s) [99.514216] [072/165] (907s left) kms_addfb_basic (basic-x-tiled-legacy) [99.599978] Starting subtest: basic-x-tiled-legacy [99.602831] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [99.891561] [073/165] (907s left) kms_addfb_basic (basic-y-tiled-legacy) [99.962759] Starting subtest: basic-y-tiled-legacy [99.965830] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [100.258538] [074/165] (906s left) kms_addfb_basic (bo-too-small) [100.555450] Starting subtest: bo-too-small [100.558362] Subtest bo-too-small: SUCCESS (0.000s) [100.652384] [075/165] (906s left) kms_addfb_basic (bo-too-small-due-to-tiling) [100.966543] Starting subtest: bo-too-small-due-to-tiling [100.969341] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [101.060673] [076/165] (905s left) kms_addfb_basic (clobberred-modifier) [101.152557] Starting subtest: clobberred-modifier [101.155839] Subtest clobberred-modifier: SUCCESS (0.000s) [101.469407] [077/165] (905s left) kms_addfb_basic (framebuffer-vs-set-tiling) [101.554920] Starting subtest: framebuffer-vs-set-tiling [101.558264] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [101.860269] [078/165] (905s left) kms_addfb_basic (invalid-get-prop) [101.950207] Starting subtest: invalid-get-prop [101.953796] Subtest invalid-get-prop: SUCCESS (0.000s) [102.254217] [079/165] (904s left) kms_addfb_basic (invalid-get-prop-any) [102.333978] Starting subtest: invalid-get-prop-any [102.337058] Subtest invalid-get-prop-any: SUCCESS (0.000s) [102.651029] [080/165] (904s left) kms_addfb_basic (invalid-set-prop) [102.741719] Starting subtest: invalid-set-prop [102.744719] Subtest invalid-set-prop: SUCCESS (0.000s) [103.038739] [081/165] (904s left) kms_addfb_basic (invalid-set-prop-any) [103.136046] Starting subtest: invalid-set-prop-any [103.139772] Subtest invalid-set-prop-any: SUCCESS (0.000s) [103.421084] [082/165] (903s left) kms_addfb_basic (no-handle) [103.500097] Starting subtest: no-handle [103.503442] Subtest no-handle: SUCCESS (0.000s) [103.792297] [083/165] (903s left) kms_addfb_basic (size-max) [104.099550] Starting subtest: size-max [104.102367] Subtest size-max: SUCCESS (0.000s) [104.175389] [084/165] (903s left) kms_addfb_basic (small-bo) [104.455478] Starting subtest: small-bo [104.458193] Subtest small-bo: SUCCESS (0.000s) [104.555878] [085/165] (902s left) kms_addfb_basic (tile-pitch-mismatch) [104.654200] Starting subtest: tile-pitch-mismatch [104.657284] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [104.945912] [086/165] (902s left) kms_addfb_basic (too-high) [105.251448] Starting subtest: too-high [105.254175] Subtest too-high: SUCCESS (0.001s) [105.345241] [087/165] (902s left) kms_addfb_basic (too-wide) [105.650055] Starting subtest: too-wide [105.652769] Subtest too-wide: SUCCESS (0.000s) [105.726024] [088/165] (901s left) kms_addfb_basic (unused-handle) [105.804636] Starting subtest: unused-handle [105.807894] Subtest unused-handle: SUCCESS (0.000s) [106.117533] [089/165] (901s left) kms_addfb_basic (unused-modifier) [106.221583] Starting subtest: unused-modifier [106.224833] Subtest unused-modifier: SUCCESS (0.000s) [106.522472] [090/165] (900s left) kms_addfb_basic (unused-offsets) [106.625480] Starting subtest: unused-offsets [106.628581] Subtest unused-offsets: SUCCESS (0.000s) [106.924393] [091/165] (900s left) kms_addfb_basic (unused-pitches) [107.010379] Starting subtest: unused-pitches [107.013505] Subtest unused-pitches: SUCCESS (0.000s) [107.300112] [092/165] (900s left) kms_busy (basic) [107.589349] Starting subtest: basic [107.592250] Starting dynamic subtest: flip [108.516365] Dynamic subtest flip: SUCCESS (0.835s) [108.581044] Starting dynamic subtest: modeset [109.689988] Dynamic subtest modeset: SUCCESS (1.161s) [109.693164] Subtest basic: SUCCESS (2.000s) [109.973340] [093/165] (897s left) kms_prop_blob (basic) [110.065596] Starting subtest: basic [110.068727] Subtest basic: SUCCESS (0.000s) [110.143402] [094/165] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [110.453084] Starting subtest: basic-busy-flip-before-cursor-atomic [110.459265] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [110.536208] [095/165] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [110.844118] Starting subtest: basic-busy-flip-before-cursor-legacy [110.849505] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [110.915925] [096/165] (896s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [111.202997] Starting subtest: basic-flip-after-cursor-atomic [112.289393] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.015s) [112.830240] [097/165] (895s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [113.378637] Starting subtest: basic-flip-after-cursor-legacy [114.398885] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.004s) [114.877214] [098/165] (893s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [115.400709] Starting subtest: basic-flip-after-cursor-varying-size [116.443659] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.015s) [116.936799] [099/165] (891s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [117.405820] Starting subtest: basic-flip-before-cursor-atomic [118.424251] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.021s) [118.820840] [100/165] (889s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [119.125949] Starting subtest: basic-flip-before-cursor-legacy [120.158150] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.035s) [120.554759] [101/165] (887s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [120.851272] Starting subtest: basic-flip-before-cursor-varying-size [121.883097] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.032s) [122.301569] [102/165] (886s left) kms_dsc (dsc-basic) [122.613178] Subtest dsc-basic: SKIP (0.000s) [122.649436] [103/165] (885s left) kms_flip (basic-flip-vs-dpms) [122.935021] Starting subtest: basic-flip-vs-dpms [122.938138] Starting dynamic subtest: A-DP1 [124.157242] Dynamic subtest A-DP1: SUCCESS (1.215s) [124.170857] Starting dynamic subtest: B-DP1 [125.192383] Dynamic subtest B-DP1: SUCCESS (1.031s) [125.203285] Starting dynamic subtest: C-DP1 [126.186215] Dynamic subtest C-DP1: SUCCESS (0.992s) [126.201265] Starting dynamic subtest: A-DP2 [127.114247] Dynamic subtest A-DP2: SUCCESS (0.930s) [127.124493] Starting dynamic subtest: B-DP2 [127.876627] Dynamic subtest B-DP2: SUCCESS (0.754s) [127.891490] Starting dynamic subtest: C-DP2 [128.774041] Dynamic subtest C-DP2: SUCCESS (0.897s) [128.777343] Subtest basic-flip-vs-dpms: SUCCESS (5.839s) [129.227436] [104/165] (879s left) kms_flip (basic-flip-vs-modeset) [129.506288] Starting subtest: basic-flip-vs-modeset [129.512595] Starting dynamic subtest: A-DP1 [130.672494] Dynamic subtest A-DP1: SUCCESS (1.158s) [130.684147] Starting dynamic subtest: B-DP1 [131.652140] Dynamic subtest B-DP1: SUCCESS (0.977s) [131.666569] Starting dynamic subtest: C-DP1 [132.649389] Dynamic subtest C-DP1: SUCCESS (0.992s) [132.665660] Starting dynamic subtest: A-DP2 [133.354129] Dynamic subtest A-DP2: SUCCESS (0.702s) [133.366283] Starting dynamic subtest: B-DP2 [134.081180] Dynamic subtest B-DP2: SUCCESS (0.728s) [134.092340] Starting dynamic subtest: C-DP2 [134.778388] Dynamic subtest C-DP2: SUCCESS (0.691s) [134.781603] Subtest basic-flip-vs-modeset: SUCCESS (5.271s) [135.230507] [105/165] (873s left) kms_flip (basic-flip-vs-wf_vblank) [135.506987] Starting subtest: basic-flip-vs-wf_vblank [135.509873] Starting dynamic subtest: A-DP1 [136.878776] Dynamic subtest A-DP1: SUCCESS (1.260s) [136.944848] Starting dynamic subtest: B-DP1 [137.902298] Dynamic subtest B-DP1: SUCCESS (1.129s) [137.913283] Starting dynamic subtest: C-DP1 [139.049039] Dynamic subtest C-DP1: SUCCESS (1.139s) [139.060824] Starting dynamic subtest: A-DP2 [140.117627] Dynamic subtest A-DP2: SUCCESS (1.074s) [140.128992] Starting dynamic subtest: B-DP2 [141.161638] Dynamic subtest B-DP2: SUCCESS (1.040s) [141.173279] Starting dynamic subtest: C-DP2 [142.225725] Dynamic subtest C-DP2: SUCCESS (1.064s) [142.229756] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.722s) [142.766048] [106/165] (865s left) kms_flip (basic-plain-flip) [143.040261] Starting subtest: basic-plain-flip [143.043346] Starting dynamic subtest: A-DP1 [143.954338] Dynamic subtest A-DP1: SUCCESS (0.913s) [143.965496] Starting dynamic subtest: B-DP1 [144.828665] Dynamic subtest B-DP1: SUCCESS (0.875s) [144.840211] Starting dynamic subtest: C-DP1 [145.686194] Dynamic subtest C-DP1: SUCCESS (0.855s) [145.717125] Starting dynamic subtest: A-DP2 [146.506191] Dynamic subtest A-DP2: SUCCESS (0.810s) [146.518629] Starting dynamic subtest: B-DP2 [147.300162] Dynamic subtest B-DP2: SUCCESS (0.790s) [147.313765] Starting dynamic subtest: C-DP2 [148.094852] Dynamic subtest C-DP2: SUCCESS (0.796s) [148.098901] Subtest basic-plain-flip: SUCCESS (5.062s) [148.622729] [107/165] (859s left) kms_force_connector_basic (force-connector-state) [148.764163] Starting subtest: force-connector-state [149.399809] Subtest force-connector-state: SUCCESS (0.639s) [150.336300] [108/165] (858s left) kms_force_connector_basic (force-edid) [150.459789] Starting subtest: force-edid [150.638309] Subtest force-edid: SUCCESS (0.182s) [151.152756] [109/165] (857s left) kms_force_connector_basic (force-load-detect) [151.277486] Starting subtest: force-load-detect [151.283588] Subtest force-load-detect: SKIP (0.000s) [151.589495] [110/165] (857s left) kms_force_connector_basic (prune-stale-modes) [151.724381] Starting subtest: prune-stale-modes [151.828576] Subtest prune-stale-modes: SUCCESS (0.108s) [152.362871] [111/165] (856s left) kms_frontbuffer_tracking (basic) [152.673064] Starting subtest: basic [155.421804] Subtest basic: SUCCESS (2.749s) [155.711806] [112/165] (853s left) kms_hdmi_inject (inject-audio) [155.936908] Starting subtest: inject-audio [156.118824] Subtest inject-audio: SUCCESS (0.179s) [156.775848] [113/165] (851s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [157.058872] Starting subtest: compare-crc-sanitycheck-xr24 [157.061803] Starting dynamic subtest: pipe-A-DP-1 [157.649310] Dynamic subtest pipe-A-DP-1: SUCCESS (0.590s) [157.669580] Starting dynamic subtest: pipe-B-DP-2 [158.136804] Dynamic subtest pipe-B-DP-2: SUCCESS (0.476s) [158.152508] Starting dynamic subtest: pipe-C-DP-1 [158.694602] Dynamic subtest pipe-C-DP-1: SUCCESS (0.554s) [158.698352] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.639s) [159.100293] [114/165] (849s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [159.408590] Starting subtest: compare-crc-sanitycheck-nv12 [159.411832] Starting dynamic subtest: pipe-A-DP-1 [160.028581] Dynamic subtest pipe-A-DP-1: SUCCESS (0.619s) [160.045941] Starting dynamic subtest: pipe-B-DP-2 [160.529765] Dynamic subtest pipe-B-DP-2: SUCCESS (0.497s) [160.548410] Starting dynamic subtest: pipe-C-DP-1 [160.554791] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [160.557792] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.131s) [160.920987] [115/165] (847s left) kms_pipe_crc_basic (hang-read-crc) [161.215930] Starting subtest: hang-read-crc [161.218826] Starting dynamic subtest: pipe-A-DP-1 [162.596012] Dynamic subtest pipe-A-DP-1: SUCCESS (1.380s) [162.612795] Starting dynamic subtest: pipe-B-DP-2 [163.778977] Dynamic subtest pipe-B-DP-2: SUCCESS (1.179s) [163.793181] Starting dynamic subtest: pipe-C-DP-1 [165.100372] Dynamic subtest pipe-C-DP-1: SUCCESS (1.312s) [165.104217] Subtest hang-read-crc: SUCCESS (3.883s) [165.487634] [116/165] (843s left) kms_pipe_crc_basic (nonblocking-crc) [165.801661] Starting subtest: nonblocking-crc [165.804591] Starting dynamic subtest: pipe-A-DP-1 [166.648130] Dynamic subtest pipe-A-DP-1: SUCCESS (0.758s) [166.716038] Starting dynamic subtest: pipe-B-DP-2 [167.292679] Dynamic subtest pipe-B-DP-2: SUCCESS (0.616s) [167.358932] Starting dynamic subtest: pipe-C-DP-1 [167.893716] Dynamic subtest pipe-C-DP-1: SUCCESS (0.709s) [167.896900] Subtest nonblocking-crc: SUCCESS (2.094s) [168.274190] [117/165] (840s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [168.568058] Starting subtest: nonblocking-crc-frame-sequence [168.570921] Starting dynamic subtest: pipe-A-DP-1 [169.328636] Dynamic subtest pipe-A-DP-1: SUCCESS (0.757s) [169.348315] Starting dynamic subtest: pipe-B-DP-2 [170.013185] Dynamic subtest pipe-B-DP-2: SUCCESS (0.681s) [170.026117] Starting dynamic subtest: pipe-C-DP-1 [170.741979] Dynamic subtest pipe-C-DP-1: SUCCESS (0.725s) [170.745540] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.177s) [171.140633] [118/165] (837s left) kms_pipe_crc_basic (read-crc) [171.465620] Starting subtest: read-crc [171.468348] Starting dynamic subtest: pipe-A-DP-1 [172.169928] Dynamic subtest pipe-A-DP-1: SUCCESS (0.702s) [172.180214] Starting dynamic subtest: pipe-B-DP-2 [172.752905] Dynamic subtest pipe-B-DP-2: SUCCESS (0.580s) [172.764524] Starting dynamic subtest: pipe-C-DP-1 [173.411087] Dynamic subtest pipe-C-DP-1: SUCCESS (0.650s) [173.414833] Subtest read-crc: SUCCESS (1.944s) [173.806510] [119/165] (835s left) kms_pipe_crc_basic (read-crc-frame-sequence) [174.106765] Starting subtest: read-crc-frame-sequence [174.109614] Starting dynamic subtest: pipe-A-DP-1 [174.838550] Dynamic subtest pipe-A-DP-1: SUCCESS (0.729s) [174.848355] Starting dynamic subtest: pipe-B-DP-2 [175.439462] Dynamic subtest pipe-B-DP-2: SUCCESS (0.597s) [175.449569] Starting dynamic subtest: pipe-C-DP-1 [176.113417] Dynamic subtest pipe-C-DP-1: SUCCESS (0.671s) [176.116302] Subtest read-crc-frame-sequence: SUCCESS (2.009s) [176.501874] [120/165] (832s left) kms_pm_backlight (basic-brightness) [176.806047] Subtest basic-brightness: SKIP (0.000s) [176.835157] [121/165] (832s left) kms_pm_rpm (basic-pci-d3-state) [178.708249] Starting subtest: basic-pci-d3-state [179.629640] Subtest basic-pci-d3-state: SUCCESS (0.918s) [180.065491] [122/165] (829s left) kms_pm_rpm (basic-rte) [180.193674] Starting subtest: basic-rte [183.123887] Subtest basic-rte: SUCCESS (2.930s) [184.329833] [123/165] (824s left) kms_psr (primary_page_flip) [184.420682] Subtest primary_page_flip: SKIP (0.000s) [184.448853] [124/165] (824s left) kms_psr (cursor_plane_move) [184.548605] Subtest cursor_plane_move: SKIP (0.000s) [184.580568] [125/165] (824s left) kms_psr (sprite_plane_onoff) [184.648828] Subtest sprite_plane_onoff: SKIP (0.000s) [184.680934] [126/165] (824s left) kms_psr (primary_mmap_gtt) [184.748138] Subtest primary_mmap_gtt: SKIP (0.000s) [184.801528] [127/165] (824s left) kms_setmode (basic-clone-single-crtc) [184.891116] Starting subtest: basic-clone-single-crtc [185.059556] Subtest basic-clone-single-crtc: SKIP (0.170s) [185.446691] [128/165] (823s left) i915_pm_rps (basic-api) [185.536514] Starting subtest: basic-api [185.539841] Subtest basic-api: SUCCESS (0.004s) [185.603571] [129/165] (823s left) prime_self_import (basic-llseek-bad) [185.675180] Starting subtest: basic-llseek-bad [185.681671] Subtest basic-llseek-bad: SUCCESS (0.002s) [185.780975] [130/165] (823s left) prime_self_import (basic-llseek-size) [185.864341] Starting subtest: basic-llseek-size [185.870577] Subtest basic-llseek-size: SUCCESS (0.003s) [185.983087] [131/165] (823s left) prime_self_import (basic-with_fd_dup) [186.066156] Starting subtest: basic-with_fd_dup [186.072656] Subtest basic-with_fd_dup: SUCCESS (0.003s) [186.167852] [132/165] (823s left) prime_self_import (basic-with_one_bo) [186.243128] Starting subtest: basic-with_one_bo [186.250218] Subtest basic-with_one_bo: SUCCESS (0.007s) [186.318289] [133/165] (823s left) prime_self_import (basic-with_one_bo_two_files) [186.397653] Starting subtest: basic-with_one_bo_two_files [186.403963] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s) [186.493618] [134/165] (823s left) prime_self_import (basic-with_two_bos) [186.572139] Starting subtest: basic-with_two_bos [186.579117] Subtest basic-with_two_bos: SUCCESS (0.005s) [186.696069] [135/165] (822s left) prime_vgem (basic-fence-flip) [186.787161] Starting subtest: basic-fence-flip [187.447727] Subtest basic-fence-flip: SUCCESS (0.659s) [187.574135] [136/165] (822s left) prime_vgem (basic-fence-mmap) [187.674155] Starting subtest: basic-fence-mmap [187.713497] Subtest basic-fence-mmap: SUCCESS (0.040s) [187.790193] [137/165] (821s left) prime_vgem (basic-fence-read) [187.873571] Starting subtest: basic-fence-read [187.915877] Subtest basic-fence-read: SUCCESS (0.046s) [188.003539] [138/165] (821s left) prime_vgem (basic-gtt) [188.086256] Starting subtest: basic-gtt [188.099479] Subtest basic-gtt: SUCCESS (0.013s) [188.207198] [139/165] (821s left) prime_vgem (basic-read) [188.316252] Starting subtest: basic-read [188.335916] Subtest basic-read: SUCCESS (0.021s) [188.429165] [140/165] (821s left) prime_vgem (basic-write) [188.524533] Starting subtest: basic-write [188.544732] Subtest basic-write: SUCCESS (0.024s) [188.621592] [141/165] (821s left) vgem_basic (setversion) [188.699805] Starting subtest: setversion [188.706256] Subtest setversion: SUCCESS (0.000s) [188.773128] [142/165] (821s left) vgem_basic (create) [188.867319] Starting subtest: create [188.871117] Subtest create: SUCCESS (0.000s) [188.938372] [143/165] (820s left) vgem_basic (debugfs) [189.035453] Starting subtest: debugfs [189.039635] Subtest debugfs: SUCCESS (0.001s) [189.102766] [144/165] (820s left) vgem_basic (dmabuf-export) [189.187365] Starting subtest: dmabuf-export [189.194897] Subtest dmabuf-export: SUCCESS (0.005s) [189.308968] [145/165] (820s left) vgem_basic (dmabuf-fence) [189.400320] Starting subtest: dmabuf-fence [189.403791] Subtest dmabuf-fence: SUCCESS (0.001s) [189.453059] [146/165] (820s left) vgem_basic (dmabuf-fence-before) [189.534472] Starting subtest: dmabuf-fence-before [189.537549] Subtest dmabuf-fence-before: SUCCESS (0.000s) [189.587069] [147/165] (820s left) vgem_basic (dmabuf-mmap) [189.666531] Starting subtest: dmabuf-mmap [189.677861] Subtest dmabuf-mmap: SUCCESS (0.013s) [189.738078] [148/165] (820s left) vgem_basic (mmap) [189.816644] Starting subtest: mmap [189.824010] Subtest mmap: SUCCESS (0.010s) [189.888405] [149/165] (820s left) vgem_basic (second-client) [189.984123] Starting subtest: second-client [190.017087] Subtest second-client: SUCCESS (0.032s) [190.088136] [150/165] (820s left) vgem_basic (sysfs) [190.183366] Starting subtest: sysfs [190.186820] Subtest sysfs: SUCCESS (0.001s) [190.235570] [151/165] (819s left) core_hotunplug (unbind-rebind) [190.364944] Starting subtest: unbind-rebind [193.869492] Subtest unbind-rebind: SUCCESS (3.504s) [193.894477] [152/165] (816s left) vgem_basic (unload) [193.972963] Starting subtest: unload [222.980110] Subtest unload: SUCCESS (29.007s) [223.107331] [153/165] (787s left) i915_module_load (reload) [223.193192] Starting subtest: reload [226.065704] Subtest reload: SUCCESS (2.874s) [226.095510] [154/165] (784s left) gem_lmem_swapping (basic) [226.223722] Subtest basic: SKIP (0.000s) [226.261814] [155/165] (784s left) gem_lmem_swapping (parallel-random-engines) [226.336982] Subtest parallel-random-engines: SKIP (0.000s) [226.361384] [156/165] (783s left) gem_lmem_swapping (random-engines) [226.435437] Subtest random-engines: SKIP (0.000s) [226.461550] [157/165] (783s left) gem_lmem_swapping (verify-random) [226.532087] Subtest verify-random: SKIP (0.000s) [226.571612] [158/165] (783s left) i915_pm_rpm (module-reload) [229.080803] Starting subtest: module-reload [236.614386] Subtest module-reload: SUCCESS (7.542s) [236.639631] [159/165] (773s left) i915_selftest (live) [236.729324] Starting subtest: live [236.732533] Starting dynamic subtest: sanitycheck [237.434870] Dynamic subtest sanitycheck: SUCCESS (0.705s) [237.445850] Starting dynamic subtest: uncore [238.115041] Dynamic subtest uncore: SUCCESS (0.678s) [238.124506] Starting dynamic subtest: workarounds [239.034242] Dynamic subtest workarounds: SUCCESS (0.915s) [239.045584] Starting dynamic subtest: gt_engines [240.256375] Dynamic subtest gt_engines: SUCCESS (1.222s) [240.268904] Starting dynamic subtest: gt_timelines [252.656905] Dynamic subtest gt_timelines: SUCCESS (12.399s) [252.667147] Starting dynamic subtest: gt_contexts [253.495158] Dynamic subtest gt_contexts: SUCCESS (0.836s) [253.504552] Starting dynamic subtest: gt_lrc [257.198281] Dynamic subtest gt_lrc: SUCCESS (3.699s) [257.208154] Starting dynamic subtest: gt_mocs [258.015099] Dynamic subtest gt_mocs: SUCCESS (0.817s) [258.024555] Starting dynamic subtest: gt_pm [264.646163] Dynamic subtest gt_pm: SUCCESS (6.629s) [264.656099] Starting dynamic subtest: gt_heartbeat [265.450226] Dynamic subtest gt_heartbeat: SUCCESS (0.800s) [265.461218] Starting dynamic subtest: gt_tlb [267.209072] Dynamic subtest gt_tlb: SUCCESS (1.759s) [267.218621] Starting dynamic subtest: requests [275.417013] Dynamic subtest requests: SUCCESS (8.206s) [275.426227] Starting dynamic subtest: migrate [278.938205] Dynamic subtest migrate: SUCCESS (3.516s) [278.947607] Starting dynamic subtest: active [279.622199] Dynamic subtest active: SUCCESS (0.683s) [279.631455] Starting dynamic subtest: objects [281.307132] Dynamic subtest objects: SUCCESS (1.683s) [281.317903] Starting dynamic subtest: mman [285.846905] Dynamic subtest mman: SUCCESS (4.540s) [285.855287] Starting dynamic subtest: dmabuf [286.606248] Dynamic subtest dmabuf: SUCCESS (0.755s) [286.616318] Starting dynamic subtest: vma [287.316027] Dynamic subtest vma: SUCCESS (0.710s) [287.327056] Starting dynamic subtest: coherency [288.969275] Dynamic subtest coherency: SUCCESS (1.649s) [288.980867] Starting dynamic subtest: gtt [296.819477] Dynamic subtest gtt: SUCCESS (7.850s) [296.831726] Starting dynamic subtest: gem [297.742247] Dynamic subtest gem: SUCCESS (0.921s) [297.755120] Starting dynamic subtest: evict [300.085264] Dynamic subtest evict: SUCCESS (2.339s) [300.094765] Starting dynamic subtest: hugepages [307.257891] Dynamic subtest hugepages: SUCCESS (7.173s) [307.268047] Starting dynamic subtest: gem_contexts [323.649978] Dynamic subtest gem_contexts: SUCCESS (16.390s) [323.658867] Starting dynamic subtest: client [324.407247] Dynamic subtest client: SUCCESS (0.753s) [324.419829] Starting dynamic subtest: gem_migrate [325.134484] Dynamic subtest gem_migrate: SUCCESS (0.727s) [325.144607] Starting dynamic subtest: reset [326.617243] Dynamic subtest reset: SUCCESS (1.478s) [326.629266] Starting dynamic subtest: memory_region [327.324889] Dynamic subtest memory_region: SUCCESS (0.709s) [327.334474] Starting dynamic subtest: hangcheck [356.544027] Dynamic subtest hangcheck: SUCCESS (29.217s) [356.553727] Starting dynamic subtest: execlists [369.603126] Dynamic subtest execlists: SUCCESS (13.057s) [369.612556] Starting dynamic subtest: ring_submission [370.291067] Dynamic subtest ring_submission: SUCCESS (0.687s) [370.300723] Starting dynamic subtest: perf [371.118391] Dynamic subtest perf: SUCCESS (0.825s) [371.128095] Starting dynamic subtest: slpc [371.831322] Dynamic subtest slpc: SUCCESS (0.650s) [371.899460] Starting dynamic subtest: guc [372.480480] Dynamic subtest guc: SUCCESS (0.672s) [372.548155] Starting dynamic subtest: guc_multi_lrc [373.184486] Dynamic subtest guc_multi_lrc: SUCCESS (0.690s) [373.193259] Starting dynamic subtest: guc_hang [373.886201] Dynamic subtest guc_hang: SUCCESS (0.696s) [373.953495] Starting dynamic subtest: late_gt_pm [374.746574] Dynamic subtest late_gt_pm: SUCCESS (0.766s) [374.750661] Subtest live: SUCCESS (137.872s) [374.781611] [160/165] (635s left) dmabuf (all-tests) [374.884171] Starting subtest: all-tests [374.887783] Starting dynamic subtest: sanitycheck [374.951386] Dynamic subtest sanitycheck: SUCCESS (0.068s) [374.972608] Starting dynamic subtest: dma_fence [375.138317] Dynamic subtest dma_fence: SUCCESS (0.184s) [375.150984] Starting dynamic subtest: dma_fence_chain [389.737125] Dynamic subtest dma_fence_chain: SUCCESS (14.599s) [389.756559] Starting dynamic subtest: dma_fence_unwrap [389.819208] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s) [389.840374] Starting dynamic subtest: dma_resv [389.893199] Dynamic subtest dma_resv: SUCCESS (0.070s) [389.897293] Subtest all-tests: SUCCESS (15.014s) [389.933763] [161/165] (620s left) i915_suspend (basic-s2idle-without-i915) [390.000814] Starting subtest: basic-s2idle-without-i915 [407.925953] Subtest basic-s2idle-without-i915: SUCCESS (3.695s) [411.550815] [162/165] (616s left) i915_suspend (basic-s3-without-i915) [411.644281] Starting subtest: basic-s3-without-i915 [430.566029] Subtest basic-s3-without-i915: SUCCESS (3.152s) [434.215753] [163/165] (612s left) gem_exec_suspend (basic-s0) [434.335756] Starting subtest: basic-S0 [434.339337] Starting dynamic subtest: smem [453.041858] Dynamic subtest smem: SUCCESS (2.901s) [453.045075] Subtest basic-S0: SUCCESS (2.903s) [458.221249] [164/165] (609s left) gem_exec_suspend (basic-s3) [458.305933] Starting subtest: basic-S3 [458.309414] Starting dynamic subtest: smem [477.808501] Dynamic subtest smem: SUCCESS (3.715s) [477.811957] Subtest basic-S3: SUCCESS (3.717s) [480.997818] [165/165] (605s left) kms_pipe_crc_basic (suspend-read-crc) [481.330456] Starting subtest: suspend-read-crc [481.333636] Starting dynamic subtest: pipe-A-DP-1 [500.691471] Dynamic subtest pipe-A-DP-1: SUCCESS (2.981s) [500.708572] Starting dynamic subtest: pipe-B-DP-2 [520.659378] Dynamic subtest pipe-B-DP-2: SUCCESS (2.723s) [520.674106] Starting dynamic subtest: pipe-C-DP-1 [540.689473] Dynamic subtest pipe-C-DP-1: SUCCESS (3.010s) [540.693097] Subtest suspend-read-crc: SUCCESS (8.725s) [545.038044] Closing watchdogs Done.