[42.553131] Initializing watchdogs [42.553305] /dev/watchdog0 [42.562901] [001/171] (960s left) i915_module_load (load) [42.828584] Starting subtest: load [45.227416] Subtest load: SUCCESS (2.399s) [45.250407] [002/171] (957s left) core_auth (basic-auth) [45.367573] Starting subtest: basic-auth [45.368823] Subtest basic-auth: SUCCESS (0.001s) [45.441656] [003/171] (957s left) debugfs_test (read_all_entries) [45.563690] Starting subtest: read_all_entries [45.629791] Subtest read_all_entries: SUCCESS (0.065s) [45.723251] [004/171] (957s left) debugfs_test (basic-hwmon) [45.843079] Starting subtest: basic-hwmon [45.844983] Subtest basic-hwmon: SKIP (0.000s) [45.939142] [005/171] (957s left) fbdev (eof) [46.078721] Starting subtest: eof [46.079869] Subtest eof: SUCCESS (0.000s) [46.148959] [006/171] (957s left) fbdev (info) [46.275768] Starting subtest: info [46.277078] Subtest info: SUCCESS (0.000s) [46.366757] [007/171] (956s left) fbdev (nullptr) [46.494718] Starting subtest: nullptr [46.495920] Subtest nullptr: SUCCESS (0.000s) [46.559352] [008/171] (956s left) fbdev (read) [46.677755] Starting subtest: read [53.765846] Subtest read: SUCCESS (7.053s) [53.809926] [009/171] (949s left) fbdev (write) [53.928231] Starting subtest: write [57.718475] Subtest write: SUCCESS (3.756s) [57.758654] [010/171] (945s left) gem_basic (bad-close) [57.871271] Starting subtest: bad-close [57.873214] Subtest bad-close: SUCCESS (0.000s) [57.944062] [011/171] (945s left) gem_basic (create-close) [58.056880] Starting subtest: create-close [58.059051] Subtest create-close: SUCCESS (0.000s) [58.161865] [012/171] (945s left) gem_basic (create-fd-close) [58.277597] Starting subtest: create-fd-close [58.279567] Subtest create-fd-close: SUCCESS (0.000s) [58.378457] [013/171] (944s left) gem_busy (busy@all-engines) [58.505580] Starting subtest: busy [58.506788] Starting dynamic subtest: all-engines [58.556343] Dynamic subtest all-engines: SUCCESS (0.051s) [58.557636] Subtest busy: SUCCESS (0.051s) [58.930343] [014/171] (944s left) gem_close_race (basic-process) [59.060094] Starting subtest: basic-process [59.130891] Subtest basic-process: SUCCESS (0.070s) [59.330439] [015/171] (944s left) gem_close_race (basic-threads) [59.463036] Starting subtest: basic-threads [60.615571] Subtest basic-threads: SUCCESS (1.152s) [60.840174] [016/171] (942s left) gem_ctx_create (basic) [60.971019] Starting subtest: basic [60.972434] Subtest basic: SUCCESS (0.000s) [61.163798] [017/171] (942s left) gem_ctx_create (basic-files) [61.288322] Starting subtest: basic-files [63.309439] Subtest basic-files: SUCCESS (2.021s) [63.541680] [018/171] (939s left) gem_ctx_exec (basic) [63.659508] Starting subtest: basic [63.665038] Subtest basic: SUCCESS (0.005s) [63.775300] [019/171] (939s left) gem_exec_basic (basic) [63.895423] Starting subtest: basic [63.896595] Starting dynamic subtest: rcs0-smem [63.897694] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [63.908795] Starting dynamic subtest: bcs0-smem [63.910010] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [63.920052] Starting dynamic subtest: vcs0-smem [63.921381] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [63.931338] Starting dynamic subtest: vecs0-smem [63.932670] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [63.933912] Subtest basic: SUCCESS (0.005s) [64.097019] [020/171] (939s left) gem_exec_create (basic) [64.222279] Starting subtest: basic [64.223422] Starting dynamic subtest: smem [66.267660] Dynamic subtest smem: SUCCESS (2.045s) [66.268764] Subtest basic: SUCCESS (2.045s) [66.487041] [021/171] (937s left) gem_exec_fence (basic-busy) [66.758099] Starting subtest: basic-busy [66.759435] Starting dynamic subtest: rcs0 [66.776209] Dynamic subtest rcs0: SUCCESS (0.027s) [66.786817] Starting dynamic subtest: bcs0 [66.802591] Dynamic subtest bcs0: SUCCESS (0.026s) [66.813073] Starting dynamic subtest: vcs0 [66.820363] Dynamic subtest vcs0: SUCCESS (0.018s) [66.830832] Starting dynamic subtest: vecs0 [66.839378] Dynamic subtest vecs0: SUCCESS (0.019s) [66.840520] Subtest basic-busy: SUCCESS (0.090s) [67.413748] [022/171] (936s left) gem_exec_fence (basic-wait) [67.686177] Starting subtest: basic-wait [67.687544] Starting dynamic subtest: rcs0 [67.704390] Dynamic subtest rcs0: SUCCESS (0.026s) [67.718335] Starting dynamic subtest: bcs0 [67.727483] Dynamic subtest bcs0: SUCCESS (0.023s) [67.738586] Starting dynamic subtest: vcs0 [67.758786] Dynamic subtest vcs0: SUCCESS (0.031s) [67.769711] Starting dynamic subtest: vecs0 [67.785969] Dynamic subtest vecs0: SUCCESS (0.027s) [67.787377] Subtest basic-wait: SUCCESS (0.108s) [68.320383] [023/171] (935s left) gem_exec_fence (basic-await) [68.592085] Starting subtest: basic-await [68.593178] Starting dynamic subtest: rcs0 [68.672352] Dynamic subtest rcs0: SUCCESS (0.087s) [68.699472] Starting dynamic subtest: bcs0 [68.793288] Dynamic subtest bcs0: SUCCESS (0.120s) [68.819153] Starting dynamic subtest: vcs0 [68.916121] Dynamic subtest vcs0: SUCCESS (0.121s) [68.942480] Starting dynamic subtest: vecs0 [69.032392] Dynamic subtest vecs0: SUCCESS (0.117s) [69.034266] Subtest basic-await: SUCCESS (0.448s) [69.598074] [024/171] (934s left) gem_exec_fence (nb-await) [69.867311] Starting subtest: nb-await [69.868408] Starting dynamic subtest: rcs0 [69.925699] Dynamic subtest rcs0: SUCCESS (0.066s) [69.943117] Starting dynamic subtest: bcs0 [69.993873] Dynamic subtest bcs0: SUCCESS (0.068s) [70.019833] Starting dynamic subtest: vcs0 [70.066361] Dynamic subtest vcs0: SUCCESS (0.072s) [70.092433] Starting dynamic subtest: vecs0 [70.139447] Dynamic subtest vecs0: SUCCESS (0.073s) [70.141366] Subtest nb-await: SUCCESS (0.280s) [70.681965] [025/171] (932s left) gem_exec_gttfill (basic) [70.811316] Starting subtest: basic [78.201500] Subtest basic: SUCCESS (7.381s) [78.378151] [026/171] (925s left) gem_exec_parallel (engines) [78.574183] Starting subtest: engines [78.575665] Starting dynamic subtest: basic [81.180363] Dynamic subtest basic: SUCCESS (2.581s) [81.192562] Starting dynamic subtest: contexts [84.385559] Dynamic subtest contexts: SUCCESS (3.222s) [84.398473] Starting dynamic subtest: fds [88.242510] Dynamic subtest fds: SUCCESS (3.857s) [88.256283] Starting dynamic subtest: userptr [90.682548] Dynamic subtest userptr: SUCCESS (2.423s) [90.684377] Subtest engines: SUCCESS (12.083s) [90.898156] [027/171] (912s left) gem_exec_store (basic) [91.026962] Starting subtest: basic [91.088491] Subtest basic: SUCCESS (0.060s) [91.280319] [028/171] (912s left) gem_flink_basic (bad-flink) [91.391673] Starting subtest: bad-flink [91.392819] Subtest bad-flink: SUCCESS (0.000s) [91.463130] [029/171] (912s left) gem_flink_basic (bad-open) [91.572707] Starting subtest: bad-open [91.573877] Subtest bad-open: SUCCESS (0.000s) [91.647192] [030/171] (912s left) gem_flink_basic (basic) [91.757565] Starting subtest: basic [91.758690] Subtest basic: SUCCESS (0.000s) [91.867593] [031/171] (911s left) gem_flink_basic (double-flink) [91.977071] Starting subtest: double-flink [91.978232] Subtest double-flink: SUCCESS (0.000s) [92.081204] [032/171] (911s left) gem_flink_basic (flink-lifetime) [92.192013] Starting subtest: flink-lifetime [92.193198] Subtest flink-lifetime: SUCCESS (0.002s) [92.299159] [033/171] (911s left) gem_huc_copy (huc-copy) [92.416334] Starting subtest: huc-copy [92.418476] Subtest huc-copy: SKIP (0.000s) [92.532428] [034/171] (911s left) gem_linear_blits (basic) [92.794635] Starting subtest: basic [92.808400] Subtest basic: SUCCESS (0.014s) [92.935275] [035/171] (910s left) gem_mmap (basic) [93.111878] Starting subtest: basic [93.117106] Subtest basic: SUCCESS (0.001s) [93.215808] [036/171] (910s left) gem_mmap_gtt (basic) [93.327248] Starting subtest: basic [93.328514] Subtest basic: SUCCESS (0.001s) [93.413228] [037/171] (910s left) gem_render_linear_blits (basic) [93.531557] Starting subtest: basic [93.581194] Subtest basic: SUCCESS (0.049s) [93.662271] [038/171] (910s left) gem_render_tiled_blits (basic) [93.778194] Starting subtest: basic [93.840705] Subtest basic: SUCCESS (0.062s) [93.897990] [039/171] (910s left) gem_ringfill (basic-all) [94.145908] Starting subtest: basic-all [95.383952] Subtest basic-all: SUCCESS (1.230s) [95.466255] [040/171] (908s left) gem_softpin (allocator-basic) [95.581302] Starting subtest: allocator-basic [95.742039] Subtest allocator-basic: SUCCESS (0.152s) [95.855586] [041/171] (908s left) gem_softpin (allocator-basic-reserve) [95.970522] Starting subtest: allocator-basic-reserve [96.129434] Subtest allocator-basic-reserve: SUCCESS (0.150s) [96.233298] [042/171] (907s left) gem_softpin (safe-alignment) [96.349038] Starting subtest: safe-alignment [96.366367] Subtest safe-alignment: SUCCESS (0.017s) [96.462997] [043/171] (907s left) gem_sync (basic-all) [96.590919] Starting subtest: basic-all [99.029817] Subtest basic-all: SUCCESS (2.422s) [99.217326] [044/171] (904s left) gem_sync (basic-each) [99.340424] Starting subtest: basic-each [101.722311] Subtest basic-each: SUCCESS (2.381s) [101.918779] [045/171] (902s left) gem_tiled_blits (basic) [102.165952] Starting subtest: basic [102.193643] Subtest basic: SUCCESS (0.028s) [102.318836] [046/171] (901s left) gem_tiled_fence_blits (basic) [102.661680] Starting subtest: basic [102.688428] Subtest basic: SUCCESS (0.027s) [102.813307] [047/171] (901s left) gem_tiled_pread_basic [103.332951] [048/171] (900s left) gem_wait (busy@all-engines) [103.466097] Starting subtest: busy [103.467278] Starting dynamic subtest: all-engines [103.991325] Dynamic subtest all-engines: SUCCESS (0.526s) [103.992368] Subtest busy: SUCCESS (0.526s) [104.234226] [049/171] (900s left) gem_wait (wait@all-engines) [104.363856] Starting subtest: wait [104.365148] Starting dynamic subtest: all-engines [105.415040] Dynamic subtest all-engines: SUCCESS (1.049s) [105.417049] Subtest wait: SUCCESS (1.049s) [105.632762] [050/171] (898s left) i915_getparams_basic (basic-eu-total) [105.743156] Starting subtest: basic-eu-total [105.745143] Subtest basic-eu-total: SUCCESS (0.000s) [105.831509] [051/171] (898s left) i915_getparams_basic (basic-subslice-total) [105.942887] Starting subtest: basic-subslice-total [105.944992] Subtest basic-subslice-total: SUCCESS (0.000s) [106.030474] [052/171] (898s left) i915_hangman (error-state-basic) [106.157358] Starting subtest: error-state-basic [106.171630] Subtest error-state-basic: SUCCESS (0.014s) [106.264457] [053/171] (898s left) i915_pciid [106.450641] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [106.597129] Starting subtest: addfb25-bad-modifier [106.598206] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [106.744431] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [106.883138] Starting subtest: addfb25-framebuffer-vs-set-tiling [106.884217] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [107.044704] [056/171] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [107.185460] Starting subtest: addfb25-modifier-no-flag [107.186517] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [107.327790] [057/171] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy) [107.466450] Starting subtest: addfb25-x-tiled-legacy [107.467584] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [107.612222] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [107.751341] Starting subtest: addfb25-x-tiled-mismatch-legacy [107.752377] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [107.894897] [059/171] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.058232] Starting subtest: addfb25-yf-tiled-legacy [108.059291] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [108.177808] [060/171] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [108.342141] Starting subtest: addfb25-y-tiled-legacy [108.343232] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [108.461034] [061/171] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [108.623841] Starting subtest: addfb25-y-tiled-small-legacy [108.624967] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [108.744771] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [108.856983] Starting subtest: bad-pitch-0 [108.858205] Subtest bad-pitch-0: SUCCESS (0.000s) [109.027776] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [109.139699] Starting subtest: bad-pitch-1024 [109.140853] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.311063] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [109.421725] Starting subtest: bad-pitch-128 [109.422869] Subtest bad-pitch-128: SUCCESS (0.000s) [109.594823] [065/171] (895s left) kms_addfb_basic (bad-pitch-256) [109.705626] Starting subtest: bad-pitch-256 [109.706789] Subtest bad-pitch-256: SUCCESS (0.000s) [109.877752] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [109.989303] Starting subtest: bad-pitch-32 [109.990395] Subtest bad-pitch-32: SUCCESS (0.000s) [110.161144] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [110.272528] Starting subtest: bad-pitch-63 [110.273619] Subtest bad-pitch-63: SUCCESS (0.000s) [110.444869] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [110.558085] Starting subtest: bad-pitch-65536 [110.559174] Subtest bad-pitch-65536: SUCCESS (0.000s) [110.728118] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [110.838493] Starting subtest: bad-pitch-999 [110.839651] Subtest bad-pitch-999: SUCCESS (0.000s) [110.994737] [070/171] (893s left) kms_addfb_basic (basic) [111.106685] Starting subtest: basic [111.107779] Subtest basic: SUCCESS (0.000s) [111.277998] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [111.465610] Starting subtest: basic-x-tiled-legacy [111.466771] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [111.561114] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [111.748441] Starting subtest: basic-y-tiled-legacy [111.749588] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [111.844552] [073/171] (892s left) kms_addfb_basic (bo-too-small) [111.983858] Starting subtest: bo-too-small [111.984947] Subtest bo-too-small: SUCCESS (0.000s) [112.127708] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [112.266516] Starting subtest: bo-too-small-due-to-tiling [112.267651] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [112.411361] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [112.522820] Starting subtest: clobberred-modifier [112.524098] Subtest clobberred-modifier: SUCCESS (0.000s) [112.694426] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [112.880860] Starting subtest: framebuffer-vs-set-tiling [112.882077] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [112.978087] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [113.164736] Starting subtest: invalid-get-prop [113.166091] Subtest invalid-get-prop: SUCCESS (0.000s) [113.261533] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [113.447206] Starting subtest: invalid-get-prop-any [113.448393] Subtest invalid-get-prop-any: SUCCESS (0.000s) [113.544359] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [113.731548] Starting subtest: invalid-set-prop [113.732709] Subtest invalid-set-prop: SUCCESS (0.000s) [113.811227] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any) [113.999882] Starting subtest: invalid-set-prop-any [114.001058] Subtest invalid-set-prop-any: SUCCESS (0.000s) [114.111188] [081/171] (890s left) kms_addfb_basic (no-handle) [114.221909] Starting subtest: no-handle [114.223289] Subtest no-handle: SUCCESS (0.000s) [114.395181] [082/171] (890s left) kms_addfb_basic (size-max) [114.533113] Starting subtest: size-max [114.534172] Subtest size-max: SUCCESS (0.000s) [114.677963] [083/171] (890s left) kms_addfb_basic (small-bo) [114.816760] Starting subtest: small-bo [114.817966] Subtest small-bo: SUCCESS (0.000s) [114.961645] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch) [115.147595] Starting subtest: tile-pitch-mismatch [115.148741] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [115.244582] [085/171] (889s left) kms_addfb_basic (too-high) [115.383807] Starting subtest: too-high [115.385068] Subtest too-high: SUCCESS (0.001s) [115.528195] [086/171] (889s left) kms_addfb_basic (too-wide) [115.666688] Starting subtest: too-wide [115.667942] Subtest too-wide: SUCCESS (0.000s) [115.811219] [087/171] (889s left) kms_addfb_basic (unused-handle) [115.922067] Starting subtest: unused-handle [115.923207] Subtest unused-handle: SUCCESS (0.000s) [116.094604] [088/171] (889s left) kms_addfb_basic (unused-modifier) [116.207056] Starting subtest: unused-modifier [116.208130] Subtest unused-modifier: SUCCESS (0.000s) [116.361228] [089/171] (888s left) kms_addfb_basic (unused-offsets) [116.472728] Starting subtest: unused-offsets [116.473901] Subtest unused-offsets: SUCCESS (0.000s) [116.649984] [090/171] (888s left) kms_addfb_basic (unused-pitches) [116.762101] Starting subtest: unused-pitches [116.763169] Subtest unused-pitches: SUCCESS (0.000s) [116.944481] [091/171] (888s left) kms_busy (basic) [117.095411] Starting subtest: basic [117.096690] Starting dynamic subtest: flip [118.064756] Dynamic subtest flip: SUCCESS (0.968s) [118.080841] Starting dynamic subtest: modeset [121.815643] Dynamic subtest modeset: SUCCESS (3.750s) [121.816857] Subtest basic: SUCCESS (4.719s) [122.784487] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [123.234694] Subtest dp-hpd-fast: SKIP (0.000s) [124.142874] [093/171] (881s left) kms_chamelium_edid (dp-edid-read) [124.595573] Subtest dp-edid-read: SKIP (0.000s) [125.487196] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [125.938717] Subtest dp-crc-fast: SKIP (0.000s) [126.832743] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [127.280523] Subtest hdmi-hpd-fast: SKIP (0.000s) [128.175764] [096/171] (877s left) kms_chamelium_edid (hdmi-edid-read) [128.624776] Subtest hdmi-edid-read: SKIP (0.000s) [129.517913] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [129.970984] Subtest hdmi-crc-fast: SKIP (0.000s) [130.864372] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [131.314664] Subtest vga-hpd-fast: SKIP (0.000s) [132.209552] [099/171] (873s left) kms_chamelium_edid (vga-edid-read) [132.655932] Subtest vga-edid-read: SKIP (0.000s) [133.551481] [100/171] (871s left) kms_prop_blob (basic) [133.667358] Starting subtest: basic [133.668444] Subtest basic: SUCCESS (0.000s) [133.752917] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [133.891622] Starting subtest: basic-busy-flip-before-cursor-atomic [133.893809] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [133.964078] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [134.102492] Starting subtest: basic-busy-flip-before-cursor-legacy [134.104652] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [134.181380] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [134.319245] Starting subtest: basic-flip-after-cursor-atomic [135.609813] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.291s) [136.541382] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [136.680152] Starting subtest: basic-flip-after-cursor-legacy [137.956399] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.275s) [138.914202] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [139.053073] Starting subtest: basic-flip-after-cursor-varying-size [140.328494] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.277s) [141.279417] [106/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [141.418497] Starting subtest: basic-flip-before-cursor-atomic [142.710234] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.292s) [143.645746] [107/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [143.786841] Starting subtest: basic-flip-before-cursor-legacy [145.074644] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.290s) [146.016396] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [146.154900] Starting subtest: basic-flip-before-cursor-varying-size [147.447357] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.291s) [148.384664] [109/171] (857s left) kms_flip (basic-flip-vs-dpms) [148.505831] Starting subtest: basic-flip-vs-dpms [148.508931] Starting dynamic subtest: A-eDP1 [151.389274] Dynamic subtest A-eDP1: SUCCESS (2.879s) [151.405080] Starting dynamic subtest: B-eDP1 [153.751997] Dynamic subtest B-eDP1: SUCCESS (2.362s) [153.777273] Starting dynamic subtest: C-eDP1 [156.120549] Dynamic subtest C-eDP1: SUCCESS (2.367s) [156.131426] Subtest basic-flip-vs-dpms: SUCCESS (7.617s) [157.087252] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [157.205615] Starting subtest: basic-flip-vs-modeset [157.209231] Starting dynamic subtest: A-eDP1 [160.082626] Dynamic subtest A-eDP1: SUCCESS (2.873s) [160.098627] Starting dynamic subtest: B-eDP1 [162.462111] Dynamic subtest B-eDP1: SUCCESS (2.373s) [162.476861] Starting dynamic subtest: C-eDP1 [164.823846] Dynamic subtest C-eDP1: SUCCESS (2.366s) [164.824982] Subtest basic-flip-vs-modeset: SUCCESS (7.620s) [165.792473] [111/171] (840s left) kms_flip (basic-flip-vs-wf_vblank) [165.927345] Starting subtest: basic-flip-vs-wf_vblank [165.930457] Starting dynamic subtest: A-eDP1 [168.258193] Dynamic subtest A-eDP1: SUCCESS (2.328s) [168.274123] Starting dynamic subtest: B-eDP1 [170.545843] Dynamic subtest B-eDP1: SUCCESS (2.286s) [170.561912] Starting dynamic subtest: C-eDP1 [172.784497] Dynamic subtest C-eDP1: SUCCESS (2.238s) [172.786975] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.861s) [174.048172] [112/171] (831s left) kms_flip (basic-plain-flip) [174.168417] Starting subtest: basic-plain-flip [174.171508] Starting dynamic subtest: A-eDP1 [176.229892] Dynamic subtest A-eDP1: SUCCESS (2.058s) [176.245955] Starting dynamic subtest: B-eDP1 [178.197787] Dynamic subtest B-eDP1: SUCCESS (1.967s) [178.213919] Starting dynamic subtest: C-eDP1 [180.185777] Dynamic subtest C-eDP1: SUCCESS (1.987s) [180.188138] Subtest basic-plain-flip: SUCCESS (6.021s) [181.471375] [113/171] (824s left) kms_force_connector_basic (force-connector-state) [181.589784] Starting subtest: force-connector-state [182.318209] Subtest force-connector-state: SUCCESS (0.730s) [183.202351] [114/171] (822s left) kms_force_connector_basic (force-edid) [183.318814] Starting subtest: force-edid [183.569210] Subtest force-edid: SUCCESS (0.251s) [183.691561] [115/171] (822s left) kms_force_connector_basic (force-load-detect) [183.807419] Starting subtest: force-load-detect [183.809902] Subtest force-load-detect: SKIP (0.000s) [183.918939] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes) [184.034454] Starting subtest: prune-stale-modes [184.346596] Subtest prune-stale-modes: SUCCESS (0.311s) [184.451976] [117/171] (821s left) kms_frontbuffer_tracking (basic) [184.596624] Starting subtest: basic [187.900819] Subtest basic: SUCCESS (3.305s) [188.028870] [118/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [188.172226] Starting subtest: compare-crc-sanitycheck [188.173487] Starting dynamic subtest: pipe-A-eDP-1 [188.851438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s) [188.867634] Starting dynamic subtest: pipe-B-eDP-1 [190.234482] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s) [190.251805] Starting dynamic subtest: pipe-C-eDP-1 [191.612682] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [191.613772] Subtest compare-crc-sanitycheck: SUCCESS (3.441s) [192.559080] [119/171] (813s left) kms_pipe_crc_basic (hang-read-crc) [192.700783] Starting subtest: hang-read-crc [192.701970] Starting dynamic subtest: pipe-A-eDP-1 [195.014189] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.314s) [195.030188] Starting dynamic subtest: pipe-B-eDP-1 [198.057271] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.043s) [198.073111] Starting dynamic subtest: pipe-C-eDP-1 [201.090446] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.031s) [201.091638] Subtest hang-read-crc: SUCCESS (8.390s) [202.015231] [120/171] (804s left) kms_pipe_crc_basic (nonblocking-crc) [202.157471] Starting subtest: nonblocking-crc [202.158755] Starting dynamic subtest: pipe-A-eDP-1 [203.014144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s) [203.029995] Starting dynamic subtest: pipe-B-eDP-1 [204.573752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.558s) [204.589684] Starting dynamic subtest: pipe-C-eDP-1 [206.171740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.598s) [206.172939] Subtest nonblocking-crc: SUCCESS (4.015s) [207.135988] [121/171] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [207.276750] Starting subtest: nonblocking-crc-frame-sequence [207.278174] Starting dynamic subtest: pipe-A-eDP-1 [208.155137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.877s) [208.170813] Starting dynamic subtest: pipe-B-eDP-1 [209.751616] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.596s) [209.767443] Starting dynamic subtest: pipe-C-eDP-1 [211.368943] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.617s) [211.370322] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.093s) [212.318660] [122/171] (793s left) kms_pipe_crc_basic (read-crc) [212.457744] Starting subtest: read-crc [212.458950] Starting dynamic subtest: pipe-A-eDP-1 [213.253684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s) [213.269545] Starting dynamic subtest: pipe-B-eDP-1 [214.739352] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [214.755255] Starting dynamic subtest: pipe-C-eDP-1 [216.277203] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s) [216.278486] Subtest read-crc: SUCCESS (3.818s) [217.245096] [123/171] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence) [217.385430] Starting subtest: read-crc-frame-sequence [217.386665] Starting dynamic subtest: pipe-A-eDP-1 [218.177481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s) [218.193462] Starting dynamic subtest: pipe-B-eDP-1 [219.687363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.508s) [219.703310] Starting dynamic subtest: pipe-C-eDP-1 [221.207653] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.520s) [221.208911] Subtest read-crc-frame-sequence: SUCCESS (3.823s) [222.177922] [124/171] (783s left) kms_psr (primary_page_flip) [222.319505] Starting subtest: primary_page_flip [224.514763] Subtest primary_page_flip: FAIL (1.910s) [224.539977] [125/171] (781s left) kms_psr (cursor_plane_move) [224.680822] Starting subtest: cursor_plane_move [226.858790] Subtest cursor_plane_move: FAIL (1.894s) [226.883967] [126/171] (779s left) kms_psr (sprite_plane_onoff) [227.026596] Starting subtest: sprite_plane_onoff [229.165857] Subtest sprite_plane_onoff: FAIL (1.858s) [229.190807] [127/171] (777s left) kms_psr (primary_mmap_gtt) [229.330196] Starting subtest: primary_mmap_gtt [231.548581] Subtest primary_mmap_gtt: FAIL (1.920s) [231.573694] [128/171] (774s left) kms_setmode (basic-clone-single-crtc) [231.689840] Starting subtest: basic-clone-single-crtc [231.692981] Subtest basic-clone-single-crtc: SKIP (0.000s) [231.772481] [129/171] (774s left) i915_pm_backlight (basic-brightness) [231.913256] Starting subtest: basic-brightness [232.020058] Starting dynamic subtest: eDP-1 [232.553078] Dynamic subtest eDP-1: SUCCESS (0.532s) [232.554297] Subtest basic-brightness: SUCCESS (0.637s) [233.502881] [130/171] (772s left) i915_pm_rpm (basic-pci-d3-state) [235.357223] Starting subtest: basic-pci-d3-state [239.743887] Subtest basic-pci-d3-state: SUCCESS (4.386s) [239.944612] [131/171] (766s left) i915_pm_rpm (basic-rte) [240.055536] Starting subtest: basic-rte [246.206315] Subtest basic-rte: SUCCESS (6.148s) [251.571691] [132/171] (754s left) i915_pm_rps (basic-api) [251.691431] Starting subtest: basic-api [251.695584] Subtest basic-api: SUCCESS (0.004s) [251.775278] [133/171] (754s left) prime_self_import (basic-llseek-bad) [251.885200] Starting subtest: basic-llseek-bad [251.888628] Subtest basic-llseek-bad: SUCCESS (0.002s) [251.975872] [134/171] (754s left) prime_self_import (basic-llseek-size) [252.085515] Starting subtest: basic-llseek-size [252.089307] Subtest basic-llseek-size: SUCCESS (0.004s) [252.192021] [135/171] (754s left) prime_self_import (basic-with_fd_dup) [252.301497] Starting subtest: basic-with_fd_dup [252.307183] Subtest basic-with_fd_dup: SUCCESS (0.004s) [252.408473] [136/171] (754s left) prime_self_import (basic-with_one_bo) [252.517649] Starting subtest: basic-with_one_bo [252.521244] Subtest basic-with_one_bo: SUCCESS (0.005s) [252.607159] [137/171] (753s left) prime_self_import (basic-with_one_bo_two_files) [252.716167] Starting subtest: basic-with_one_bo_two_files [252.719633] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [252.824565] [138/171] (753s left) prime_self_import (basic-with_two_bos) [252.934278] Starting subtest: basic-with_two_bos [252.939759] Subtest basic-with_two_bos: SUCCESS (0.004s) [253.041906] [139/171] (753s left) prime_vgem (basic-fence-flip) [253.177514] Starting subtest: basic-fence-flip [253.701537] Subtest basic-fence-flip: SUCCESS (0.524s) [253.823394] [140/171] (752s left) prime_vgem (basic-fence-mmap) [253.943541] Starting subtest: basic-fence-mmap [253.985672] Subtest basic-fence-mmap: SUCCESS (0.042s) [254.109483] [141/171] (752s left) prime_vgem (basic-fence-read) [254.252269] Starting subtest: basic-fence-read [254.319197] Subtest basic-fence-read: SUCCESS (0.067s) [254.410389] [142/171] (752s left) prime_vgem (basic-gtt) [254.543397] Starting subtest: basic-gtt [254.565464] Subtest basic-gtt: SUCCESS (0.022s) [254.676120] [143/171] (752s left) prime_vgem (basic-read) [254.822049] Starting subtest: basic-read [254.855719] Subtest basic-read: SUCCESS (0.034s) [254.958138] [144/171] (751s left) prime_vgem (basic-write) [255.093640] Starting subtest: basic-write [255.133486] Subtest basic-write: SUCCESS (0.040s) [255.229354] [145/171] (751s left) prime_vgem (basic-userptr) [255.367363] Starting subtest: basic-userptr [255.381787] Subtest basic-userptr: SKIP (0.013s) [255.497156] [146/171] (751s left) vgem_basic (setversion) [255.619462] Starting subtest: setversion [255.621617] Subtest setversion: SUCCESS (0.000s) [255.689049] [147/171] (751s left) vgem_basic (create) [255.802578] Starting subtest: create [255.803804] Subtest create: SUCCESS (0.000s) [255.872560] [148/171] (750s left) vgem_basic (debugfs) [255.985805] Starting subtest: debugfs [255.986964] Subtest debugfs: SUCCESS (0.001s) [256.059437] [149/171] (750s left) vgem_basic (dmabuf-export) [256.186371] Starting subtest: dmabuf-export [256.209162] Subtest dmabuf-export: SUCCESS (0.020s) [256.309191] [150/171] (750s left) vgem_basic (dmabuf-fence) [256.436253] Starting subtest: dmabuf-fence [256.437444] Subtest dmabuf-fence: SUCCESS (0.001s) [256.509263] [151/171] (750s left) vgem_basic (dmabuf-fence-before) [256.636447] Starting subtest: dmabuf-fence-before [256.637623] Subtest dmabuf-fence-before: SUCCESS (0.000s) [256.708081] [152/171] (750s left) vgem_basic (dmabuf-mmap) [256.836414] Starting subtest: dmabuf-mmap [256.862919] Subtest dmabuf-mmap: SUCCESS (0.027s) [256.920638] [153/171] (750s left) vgem_basic (mmap) [257.035815] Starting subtest: mmap [257.052377] Subtest mmap: SUCCESS (0.016s) [257.122349] [154/171] (749s left) vgem_basic (second-client) [257.235813] Starting subtest: second-client [257.287034] Subtest second-client: SUCCESS (0.050s) [257.358931] [155/171] (749s left) vgem_basic (sysfs) [257.486365] Starting subtest: sysfs [257.487560] Subtest sysfs: SUCCESS (0.001s) [257.557917] [156/171] (749s left) core_hotunplug (unbind-rebind) [257.703374] Starting subtest: unbind-rebind [260.062102] Subtest unbind-rebind: SUCCESS (2.359s) [260.094829] [157/171] (746s left) vgem_basic (unload) [260.214335] Starting subtest: unload [289.034900] Subtest unload: SUCCESS (28.786s) [289.119435] [158/171] (717s left) i915_module_load (reload) [289.234656] Starting subtest: reload [292.388184] Subtest reload: SUCCESS (3.153s) [292.416276] [159/171] (714s left) gem_lmem_swapping (basic) [292.549342] Subtest basic: SKIP (0.000s) [292.589378] [160/171] (714s left) gem_lmem_swapping (parallel-random-engines) [292.708836] Subtest parallel-random-engines: SKIP (0.000s) [292.755995] [161/171] (714s left) gem_lmem_swapping (random-engines) [292.876312] Subtest random-engines: SKIP (0.000s) [292.922892] [162/171] (714s left) gem_lmem_swapping (verify-random) [293.045731] Subtest verify-random: SKIP (0.000s) [293.089544] [163/171] (714s left) i915_pm_rpm (module-reload) [305.574489] Starting subtest: module-reload [339.821834] Subtest module-reload: SUCCESS (34.240s) [339.841315] [164/171] (667s left) i915_selftest (live) [339.966048] Starting subtest: live [339.967546] Starting dynamic subtest: sanitycheck [341.775508] Dynamic subtest sanitycheck: SUCCESS (1.800s) [341.790021] Starting dynamic subtest: uncore [343.567704] Dynamic subtest uncore: SUCCESS (1.791s) [343.582263] Starting dynamic subtest: workarounds [345.578638] Dynamic subtest workarounds: SUCCESS (2.010s) [345.593219] Starting dynamic subtest: gt_engines [347.813537] Dynamic subtest gt_engines: SUCCESS (2.234s) [347.828163] Starting dynamic subtest: gt_timelines [359.656495] Dynamic subtest gt_timelines: SUCCESS (11.842s) [359.671328] Starting dynamic subtest: gt_contexts [361.517430] Dynamic subtest gt_contexts: SUCCESS (1.860s) [361.532102] Starting dynamic subtest: gt_lrc [365.731615] Dynamic subtest gt_lrc: SUCCESS (4.213s) [365.746227] Starting dynamic subtest: gt_mocs [367.582566] Dynamic subtest gt_mocs: SUCCESS (1.850s) [367.598199] Starting dynamic subtest: gt_pm [372.603501] Dynamic subtest gt_pm: SUCCESS (5.020s) [372.618198] Starting dynamic subtest: gt_heartbeat [374.480557] Dynamic subtest gt_heartbeat: SUCCESS (1.876s) [374.495316] Starting dynamic subtest: requests [382.002943] Dynamic subtest requests: SUCCESS (7.521s) [382.017611] Starting dynamic subtest: migrate [386.520447] Dynamic subtest migrate: SUCCESS (4.517s) [386.535151] Starting dynamic subtest: active [388.318526] Dynamic subtest active: SUCCESS (1.797s) [388.333205] Starting dynamic subtest: objects [391.654330] Dynamic subtest objects: SUCCESS (3.335s) [391.669101] Starting dynamic subtest: mman [398.531574] Dynamic subtest mman: SUCCESS (6.876s) [398.546432] Starting dynamic subtest: dmabuf [400.354635] Dynamic subtest dmabuf: SUCCESS (1.822s) [400.369513] Starting dynamic subtest: vma [402.128641] Dynamic subtest vma: SUCCESS (1.773s) [402.143547] Starting dynamic subtest: coherency [407.863807] Dynamic subtest coherency: SUCCESS (5.734s) [407.878684] Starting dynamic subtest: gtt [418.993471] Dynamic subtest gtt: SUCCESS (11.129s) [419.008305] Starting dynamic subtest: gem [420.912629] Dynamic subtest gem: SUCCESS (1.918s) [420.927736] Starting dynamic subtest: evict [424.538802] Dynamic subtest evict: SUCCESS (3.625s) [424.553849] Starting dynamic subtest: hugepages [431.331465] Dynamic subtest hugepages: SUCCESS (6.792s) [431.349030] Starting dynamic subtest: gem_contexts [446.230523] Dynamic subtest gem_contexts: SUCCESS (14.898s) [446.245961] Starting dynamic subtest: client [448.027434] Dynamic subtest client: SUCCESS (1.796s) [448.042892] Starting dynamic subtest: gem_migrate [449.819529] Dynamic subtest gem_migrate: SUCCESS (1.791s) [449.834868] Starting dynamic subtest: reset [455.140560] Dynamic subtest reset: SUCCESS (5.320s) [455.156069] Starting dynamic subtest: memory_region [456.924521] Dynamic subtest memory_region: SUCCESS (1.783s) [456.939957] Starting dynamic subtest: hangcheck [481.293608] Dynamic subtest hangcheck: SUCCESS (24.368s) [481.309109] Starting dynamic subtest: execlists [491.231525] Dynamic subtest execlists: SUCCESS (9.937s) [491.247047] Starting dynamic subtest: ring_submission [493.034526] Dynamic subtest ring_submission: SUCCESS (1.802s) [493.049924] Starting dynamic subtest: perf [494.938414] Dynamic subtest perf: SUCCESS (1.903s) [494.953873] Starting dynamic subtest: slpc [496.664491] Dynamic subtest slpc: SUCCESS (1.725s) [496.679922] Starting dynamic subtest: guc [498.469550] Dynamic subtest guc: SUCCESS (1.804s) [498.485069] Starting dynamic subtest: guc_multi_lrc [500.181539] Dynamic subtest guc_multi_lrc: SUCCESS (1.711s) [500.197049] Starting dynamic subtest: guc_hang [501.978753] Dynamic subtest guc_hang: SUCCESS (1.796s) [501.994189] Starting dynamic subtest: late_gt_pm [503.763497] Dynamic subtest late_gt_pm: SUCCESS (1.784s) [503.764815] Subtest live: SUCCESS (163.789s) [503.840364] [165/171] (503s left) dmabuf (all-tests) [503.959674] Starting subtest: all-tests [503.961498] Starting dynamic subtest: sanitycheck [503.986771] Dynamic subtest sanitycheck: SUCCESS (0.026s) [504.000269] Starting dynamic subtest: dma_fence [504.125905] Dynamic subtest dma_fence: SUCCESS (0.138s) [504.138416] Starting dynamic subtest: dma_fence_chain [521.713409] Dynamic subtest dma_fence_chain: SUCCESS (17.578s) [521.726983] Starting dynamic subtest: dma_fence_unwrap [521.733402] Dynamic subtest dma_fence_unwrap: SUCCESS (0.028s) [521.745966] Starting dynamic subtest: dma_resv [521.757469] Dynamic subtest dma_resv: SUCCESS (0.023s) [521.758584] Subtest all-tests: SUCCESS (17.798s) [521.782975] [166/171] (485s left) i915_suspend (basic-s2idle-without-i915) [521.892276] Starting subtest: basic-s2idle-without-i915 [545.237775] Subtest basic-s2idle-without-i915: SUCCESS (8.011s) [545.553860] [167/171] (477s left) i915_suspend (basic-s3-without-i915) [545.669051] Starting subtest: basic-s3-without-i915 [569.362604] Subtest basic-s3-without-i915: SUCCESS (6.957s) [569.659170] [168/171] (469s left) gem_exec_suspend (basic-s0) [569.795600] Starting subtest: basic-S0 [569.797043] Starting dynamic subtest: smem [588.339253] Dynamic subtest smem: SUCCESS (3.626s) [588.340278] Subtest basic-S0: SUCCESS (3.627s) [588.484702] [169/171] (465s left) gem_exec_suspend (basic-s3) [588.613564] Starting subtest: basic-S3 [588.614674] Starting dynamic subtest: smem [607.317211] Dynamic subtest smem: SUCCESS (3.428s) [607.318345] Subtest basic-S3: SUCCESS (3.428s) [607.472414] [170/171] (462s left) kms_chamelium_hpd (common-hpd-after-suspend) [607.931938] Subtest common-hpd-after-suspend: SKIP (0.000s) [608.803552] [171/171] (460s left) kms_pipe_crc_basic (suspend-read-crc) [608.947869] Starting subtest: suspend-read-crc [608.949076] Starting dynamic subtest: pipe-A-eDP-1 [626.334544] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.423s) [626.353234] Starting dynamic subtest: pipe-B-eDP-1 [644.262078] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.053s) [644.281210] Starting dynamic subtest: pipe-C-eDP-1 [662.267322] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.089s) [662.268441] Subtest suspend-read-crc: SUCCESS (8.568s) [663.160884] Closing watchdogs Done.