[42.253332] Initializing watchdogs [42.253472] /dev/watchdog0 [42.262983] [001/165] (960s left) i915_module_load (load) [42.364294] Starting subtest: load [44.903666] Subtest load: SUCCESS (2.540s) [44.927105] [002/165] (957s left) core_auth (basic-auth) [45.023808] Starting subtest: basic-auth [45.025212] Subtest basic-auth: SUCCESS (0.002s) [45.105604] [003/165] (957s left) debugfs_test (read_all_entries) [45.205161] Starting subtest: read_all_entries [45.274568] Subtest read_all_entries: SUCCESS (0.068s) [45.391019] [004/165] (957s left) debugfs_test (basic-hwmon) [45.485951] Starting subtest: basic-hwmon [45.488374] Subtest basic-hwmon: SKIP (0.000s) [45.590964] [005/165] (957s left) fbdev (eof) [45.690725] Starting subtest: eof [45.693062] Subtest eof: SUCCESS (0.001s) [45.757848] [006/165] (957s left) fbdev (info) [45.875906] Starting subtest: info [45.877387] Subtest info: SUCCESS (0.000s) [45.953143] [007/165] (956s left) fbdev (nullptr) [46.057251] Starting subtest: nullptr [46.058421] Subtest nullptr: SUCCESS (0.000s) [46.121218] [008/165] (956s left) fbdev (read) [46.222890] Starting subtest: read [53.279931] Subtest read: SUCCESS (7.047s) [53.348623] [009/165] (949s left) fbdev (write) [53.445982] Starting subtest: write [57.219995] Subtest write: SUCCESS (3.739s) [57.267125] [010/165] (945s left) gem_basic (bad-close) [57.357943] Starting subtest: bad-close [57.360212] Subtest bad-close: SUCCESS (0.000s) [57.438783] [011/165] (945s left) gem_basic (create-close) [57.528414] Starting subtest: create-close [57.530669] Subtest create-close: SUCCESS (0.000s) [57.621762] [012/165] (945s left) gem_basic (create-fd-close) [57.709746] Starting subtest: create-fd-close [57.717440] Subtest create-fd-close: SUCCESS (0.000s) [57.806446] [013/165] (945s left) gem_busy (busy@all-engines) [57.915762] Starting subtest: busy [57.917088] Starting dynamic subtest: all-engines [57.978058] Dynamic subtest all-engines: SUCCESS (0.062s) [57.979199] Subtest busy: SUCCESS (0.063s) [58.375522] [014/165] (944s left) gem_close_race (basic-process) [58.488967] Starting subtest: basic-process [58.560858] Subtest basic-process: SUCCESS (0.073s) [58.774103] [015/165] (944s left) gem_close_race (basic-threads) [58.886396] Starting subtest: basic-threads [60.175763] Subtest basic-threads: SUCCESS (1.289s) [60.407522] [016/165] (942s left) gem_ctx_create (basic) [60.513830] Starting subtest: basic [60.515070] Subtest basic: SUCCESS (0.000s) [60.726619] [017/165] (942s left) gem_ctx_create (basic-files) [60.828948] Starting subtest: basic-files [62.856197] Subtest basic-files: SUCCESS (2.027s) [63.077559] [018/165] (940s left) gem_ctx_exec (basic) [63.170615] Starting subtest: basic [63.176157] Subtest basic: SUCCESS (0.005s) [63.295453] [019/165] (939s left) gem_exec_basic (basic) [63.397667] Starting subtest: basic [63.398880] Starting dynamic subtest: rcs0-smem [63.400147] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [63.411618] Starting dynamic subtest: bcs0-smem [63.412802] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [63.423383] Starting dynamic subtest: vcs0-smem [63.424760] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [63.435618] Starting dynamic subtest: vecs0-smem [63.437312] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [63.438809] Subtest basic: SUCCESS (0.005s) [63.613279] [020/165] (939s left) gem_exec_create (basic) [63.718030] Starting subtest: basic [63.719239] Starting dynamic subtest: smem [65.764700] Dynamic subtest smem: SUCCESS (2.047s) [65.765908] Subtest basic: SUCCESS (2.047s) [66.014691] [021/165] (937s left) gem_exec_fence (basic-busy) [66.268986] Starting subtest: basic-busy [66.270242] Starting dynamic subtest: rcs0 [66.299923] Dynamic subtest rcs0: SUCCESS (0.038s) [66.315411] Starting dynamic subtest: bcs0 [66.333364] Dynamic subtest bcs0: SUCCESS (0.033s) [66.347570] Starting dynamic subtest: vcs0 [66.356429] Dynamic subtest vcs0: SUCCESS (0.023s) [66.367548] Starting dynamic subtest: vecs0 [66.380442] Dynamic subtest vecs0: SUCCESS (0.024s) [66.381584] Subtest basic-busy: SUCCESS (0.120s) [66.971377] [022/165] (936s left) gem_exec_fence (basic-wait) [67.221488] Starting subtest: basic-wait [67.222729] Starting dynamic subtest: rcs0 [67.245518] Dynamic subtest rcs0: SUCCESS (0.032s) [67.259742] Starting dynamic subtest: bcs0 [67.279729] Dynamic subtest bcs0: SUCCESS (0.033s) [67.295050] Starting dynamic subtest: vcs0 [67.309518] Dynamic subtest vcs0: SUCCESS (0.030s) [67.323084] Starting dynamic subtest: vecs0 [67.334638] Dynamic subtest vecs0: SUCCESS (0.025s) [67.335789] Subtest basic-wait: SUCCESS (0.122s) [67.869669] [023/165] (935s left) gem_exec_fence (basic-await) [68.122342] Starting subtest: basic-await [68.123466] Starting dynamic subtest: rcs0 [68.215512] Dynamic subtest rcs0: SUCCESS (0.100s) [68.233996] Starting dynamic subtest: bcs0 [68.319887] Dynamic subtest bcs0: SUCCESS (0.104s) [68.341979] Starting dynamic subtest: vcs0 [68.432187] Dynamic subtest vcs0: SUCCESS (0.111s) [68.459789] Starting dynamic subtest: vecs0 [68.563494] Dynamic subtest vecs0: SUCCESS (0.129s) [68.568438] Subtest basic-await: SUCCESS (0.448s) [69.134734] [024/165] (934s left) gem_exec_fence (nb-await) [69.389288] Starting subtest: nb-await [69.390363] Starting dynamic subtest: rcs0 [69.444414] Dynamic subtest rcs0: SUCCESS (0.063s) [69.463851] Starting dynamic subtest: bcs0 [69.514713] Dynamic subtest bcs0: SUCCESS (0.070s) [69.535078] Starting dynamic subtest: vcs0 [69.586476] Dynamic subtest vcs0: SUCCESS (0.071s) [69.614244] Starting dynamic subtest: vecs0 [69.659928] Dynamic subtest vecs0: SUCCESS (0.073s) [69.661948] Subtest nb-await: SUCCESS (0.279s) [70.220427] [025/165] (933s left) gem_exec_gttfill (basic) [70.327035] Starting subtest: basic [76.689242] Subtest basic: SUCCESS (6.354s) [76.876112] [026/165] (926s left) gem_exec_parallel (engines) [77.054360] Starting subtest: engines [77.055542] Starting dynamic subtest: basic [79.427608] Dynamic subtest basic: SUCCESS (2.355s) [79.442543] Starting dynamic subtest: contexts [83.115333] Dynamic subtest contexts: SUCCESS (3.699s) [83.128465] Starting dynamic subtest: fds [91.001950] Dynamic subtest fds: SUCCESS (7.894s) [91.030508] Starting dynamic subtest: userptr [93.428788] Dynamic subtest userptr: SUCCESS (2.397s) [93.430786] Subtest engines: SUCCESS (16.348s) [93.646796] [027/165] (909s left) gem_exec_store (basic) [93.755032] Starting subtest: basic [93.798726] Subtest basic: SUCCESS (0.044s) [94.015295] [028/165] (909s left) gem_flink_basic (bad-flink) [94.104678] Starting subtest: bad-flink [94.105854] Subtest bad-flink: SUCCESS (0.000s) [94.195970] [029/165] (909s left) gem_flink_basic (bad-open) [94.286326] Starting subtest: bad-open [94.287712] Subtest bad-open: SUCCESS (0.000s) [94.383312] [030/165] (909s left) gem_flink_basic (basic) [94.473315] Starting subtest: basic [94.474357] Subtest basic: SUCCESS (0.000s) [94.563895] [031/165] (909s left) gem_flink_basic (double-flink) [94.651693] Starting subtest: double-flink [94.652770] Subtest double-flink: SUCCESS (0.000s) [94.768081] [032/165] (908s left) gem_flink_basic (flink-lifetime) [94.857391] Starting subtest: flink-lifetime [94.858601] Subtest flink-lifetime: SUCCESS (0.002s) [94.971017] [033/165] (908s left) gem_huc_copy (huc-copy) [95.066967] Starting subtest: huc-copy [95.069238] Subtest huc-copy: SKIP (0.000s) [95.180741] [034/165] (908s left) gem_linear_blits (basic) [95.420464] Starting subtest: basic [95.437456] Subtest basic: SUCCESS (0.017s) [95.584317] [035/165] (908s left) gem_mmap (basic) [95.743544] Starting subtest: basic [95.748609] Subtest basic: SUCCESS (0.001s) [95.831423] [036/165] (907s left) gem_mmap_gtt (basic) [95.919835] Starting subtest: basic [95.921120] Subtest basic: SUCCESS (0.001s) [96.008396] [037/165] (907s left) gem_render_linear_blits (basic) [96.105900] Starting subtest: basic [96.157325] Subtest basic: SUCCESS (0.051s) [96.224414] [038/165] (907s left) gem_render_tiled_blits (basic) [96.318479] Starting subtest: basic [96.383122] Subtest basic: SUCCESS (0.064s) [96.440456] [039/165] (907s left) gem_ringfill (basic-all) [96.678145] Starting subtest: basic-all [97.908775] Subtest basic-all: SUCCESS (1.222s) [97.984253] [040/165] (905s left) gem_softpin (allocator-basic) [98.082204] Starting subtest: allocator-basic [98.250420] Subtest allocator-basic: SUCCESS (0.160s) [98.367779] [041/165] (905s left) gem_softpin (allocator-basic-reserve) [98.462148] Starting subtest: allocator-basic-reserve [98.633038] Subtest allocator-basic-reserve: SUCCESS (0.161s) [98.752231] [042/165] (905s left) gem_softpin (safe-alignment) [98.850546] Starting subtest: safe-alignment [98.867703] Subtest safe-alignment: SUCCESS (0.017s) [98.969587] [043/165] (904s left) gem_sync (basic-all) [99.075981] Starting subtest: basic-all [101.324112] Subtest basic-all: SUCCESS (2.225s) [101.505577] [044/165] (902s left) gem_sync (basic-each) [101.611932] Starting subtest: basic-each [103.898417] Subtest basic-each: SUCCESS (2.285s) [104.140608] [045/165] (899s left) gem_tiled_blits (basic) [104.357858] Starting subtest: basic [104.386551] Subtest basic: SUCCESS (0.029s) [104.527319] [046/165] (899s left) gem_tiled_fence_blits (basic) [104.825828] Starting subtest: basic [104.853253] Subtest basic: SUCCESS (0.028s) [104.990897] [047/165] (899s left) gem_tiled_pread_basic [105.508563] [048/165] (898s left) gem_wait (busy@all-engines) [105.624292] Starting subtest: busy [105.625445] Starting dynamic subtest: all-engines [106.142066] Dynamic subtest all-engines: SUCCESS (0.514s) [106.143225] Subtest busy: SUCCESS (0.515s) [106.394323] [049/165] (897s left) gem_wait (wait@all-engines) [106.505502] Starting subtest: wait [106.506663] Starting dynamic subtest: all-engines [107.538207] Dynamic subtest all-engines: SUCCESS (1.030s) [107.539939] Subtest wait: SUCCESS (1.030s) [107.779484] [050/165] (896s left) i915_getparams_basic (basic-eu-total) [107.870736] Starting subtest: basic-eu-total [107.873075] Subtest basic-eu-total: SUCCESS (0.000s) [107.960793] [051/165] (896s left) i915_getparams_basic (basic-subslice-total) [108.050570] Starting subtest: basic-subslice-total [108.052690] Subtest basic-subslice-total: SUCCESS (0.000s) [108.144235] [052/165] (896s left) i915_hangman (error-state-basic) [108.249800] Starting subtest: error-state-basic [108.262681] Subtest error-state-basic: SUCCESS (0.012s) [108.362766] [053/165] (895s left) i915_pciid [108.546911] [054/165] (895s left) kms_addfb_basic (addfb25-4-tiled) [108.672402] Starting subtest: addfb25-4-tiled [108.673606] Subtest addfb25-4-tiled: SUCCESS (0.000s) [108.756714] [055/165] (895s left) kms_addfb_basic (addfb25-bad-modifier) [108.846516] Starting subtest: addfb25-bad-modifier [108.847639] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [108.979639] [056/165] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [109.071511] Starting subtest: addfb25-framebuffer-vs-set-tiling [109.072550] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.196507] [057/165] (895s left) kms_addfb_basic (addfb25-modifier-no-flag) [109.285855] Starting subtest: addfb25-modifier-no-flag [109.286963] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [109.413278] [058/165] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy) [109.503120] Starting subtest: addfb25-x-tiled-legacy [109.504189] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [109.629120] [059/165] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [109.719866] Starting subtest: addfb25-x-tiled-mismatch-legacy [109.721039] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [109.844742] [060/165] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [109.964081] Starting subtest: addfb25-yf-tiled-legacy [109.965327] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [110.064116] [061/165] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy) [110.182733] Starting subtest: addfb25-y-tiled-legacy [110.183961] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [110.280099] [062/165] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [110.400732] Starting subtest: addfb25-y-tiled-small-legacy [110.401854] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [110.496416] [063/165] (894s left) kms_addfb_basic (bad-pitch-0) [110.588229] Starting subtest: bad-pitch-0 [110.589272] Subtest bad-pitch-0: SUCCESS (0.000s) [110.731834] [064/165] (893s left) kms_addfb_basic (bad-pitch-1024) [110.821516] Starting subtest: bad-pitch-1024 [110.822548] Subtest bad-pitch-1024: SUCCESS (0.000s) [110.966376] [065/165] (893s left) kms_addfb_basic (bad-pitch-128) [111.055607] Starting subtest: bad-pitch-128 [111.056950] Subtest bad-pitch-128: SUCCESS (0.000s) [111.178582] [066/165] (893s left) kms_addfb_basic (bad-pitch-256) [111.267918] Starting subtest: bad-pitch-256 [111.268990] Subtest bad-pitch-256: SUCCESS (0.000s) [111.399609] [067/165] (893s left) kms_addfb_basic (bad-pitch-32) [111.491373] Starting subtest: bad-pitch-32 [111.492478] Subtest bad-pitch-32: SUCCESS (0.000s) [111.615461] [068/165] (893s left) kms_addfb_basic (bad-pitch-63) [111.705878] Starting subtest: bad-pitch-63 [111.707151] Subtest bad-pitch-63: SUCCESS (0.000s) [111.849590] [069/165] (892s left) kms_addfb_basic (bad-pitch-65536) [111.938540] Starting subtest: bad-pitch-65536 [111.939655] Subtest bad-pitch-65536: SUCCESS (0.000s) [112.065284] [070/165] (892s left) kms_addfb_basic (bad-pitch-999) [112.156345] Starting subtest: bad-pitch-999 [112.157514] Subtest bad-pitch-999: SUCCESS (0.000s) [112.278222] [071/165] (892s left) kms_addfb_basic (basic) [112.368544] Starting subtest: basic [112.369810] Subtest basic: SUCCESS (0.000s) [112.500618] [072/165] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [112.592451] Starting subtest: basic-x-tiled-legacy [112.593482] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.715840] [073/165] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [112.807230] Starting subtest: basic-y-tiled-legacy [112.808380] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [112.935225] [074/165] (891s left) kms_addfb_basic (bo-too-small) [113.055175] Starting subtest: bo-too-small [113.056364] Subtest bo-too-small: SUCCESS (0.000s) [113.168232] [075/165] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.288639] Starting subtest: bo-too-small-due-to-tiling [113.289759] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [113.377854] [076/165] (891s left) kms_addfb_basic (clobberred-modifier) [113.468981] Starting subtest: clobberred-modifier [113.470200] Subtest clobberred-modifier: SUCCESS (0.000s) [113.602356] [077/165] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.692104] Starting subtest: framebuffer-vs-set-tiling [113.693224] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.817162] [078/165] (891s left) kms_addfb_basic (invalid-get-prop) [113.906907] Starting subtest: invalid-get-prop [113.908093] Subtest invalid-get-prop: SUCCESS (0.000s) [114.034226] [079/165] (890s left) kms_addfb_basic (invalid-get-prop-any) [114.125596] Starting subtest: invalid-get-prop-any [114.126911] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.251924] [080/165] (890s left) kms_addfb_basic (invalid-set-prop) [114.342461] Starting subtest: invalid-set-prop [114.343532] Subtest invalid-set-prop: SUCCESS (0.000s) [114.467567] [081/165] (890s left) kms_addfb_basic (invalid-set-prop-any) [114.558144] Starting subtest: invalid-set-prop-any [114.559211] Subtest invalid-set-prop-any: SUCCESS (0.000s) [114.679438] [082/165] (890s left) kms_addfb_basic (no-handle) [114.768672] Starting subtest: no-handle [114.769713] Subtest no-handle: SUCCESS (0.000s) [114.900285] [083/165] (890s left) kms_addfb_basic (size-max) [115.020677] Starting subtest: size-max [115.021771] Subtest size-max: SUCCESS (0.000s) [115.113118] [084/165] (889s left) kms_addfb_basic (small-bo) [115.231609] Starting subtest: small-bo [115.232805] Subtest small-bo: SUCCESS (0.000s) [115.338152] [085/165] (889s left) kms_addfb_basic (tile-pitch-mismatch) [115.429702] Starting subtest: tile-pitch-mismatch [115.430797] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [115.570112] [086/165] (889s left) kms_addfb_basic (too-high) [115.689425] Starting subtest: too-high [115.690604] Subtest too-high: SUCCESS (0.001s) [115.785958] [087/165] (889s left) kms_addfb_basic (too-wide) [115.906825] Starting subtest: too-wide [115.907972] Subtest too-wide: SUCCESS (0.000s) [115.999096] [088/165] (889s left) kms_addfb_basic (unused-handle) [116.088322] Starting subtest: unused-handle [116.089410] Subtest unused-handle: SUCCESS (0.000s) [116.220094] [089/165] (889s left) kms_addfb_basic (unused-modifier) [116.311319] Starting subtest: unused-modifier [116.312351] Subtest unused-modifier: SUCCESS (0.000s) [116.454927] [090/165] (888s left) kms_addfb_basic (unused-offsets) [116.546389] Starting subtest: unused-offsets [116.547466] Subtest unused-offsets: SUCCESS (0.000s) [116.671053] [091/165] (888s left) kms_addfb_basic (unused-pitches) [116.759215] Starting subtest: unused-pitches [116.760334] Subtest unused-pitches: SUCCESS (0.000s) [116.907160] [092/165] (888s left) kms_busy (basic) [117.032492] Starting subtest: basic [117.035295] Starting dynamic subtest: flip [118.053333] Dynamic subtest flip: SUCCESS (1.019s) [118.070085] Starting dynamic subtest: modeset [121.949300] Dynamic subtest modeset: SUCCESS (3.893s) [121.950424] Subtest basic: SUCCESS (4.915s) [122.904101] [093/165] (882s left) kms_prop_blob (basic) [122.995966] Starting subtest: basic [122.997229] Subtest basic: SUCCESS (0.000s) [123.097709] [094/165] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [123.216369] Starting subtest: basic-busy-flip-before-cursor-atomic [123.218457] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [123.295726] [095/165] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [123.412883] Starting subtest: basic-busy-flip-before-cursor-legacy [123.415206] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [123.496827] [096/165] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [123.614516] Starting subtest: basic-flip-after-cursor-atomic [124.913982] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.300s) [125.854426] [097/165] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [125.974054] Starting subtest: basic-flip-after-cursor-legacy [127.281533] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.308s) [128.212574] [098/165] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [128.331360] Starting subtest: basic-flip-after-cursor-varying-size [129.607707] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.276s) [130.581925] [099/165] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [130.699823] Starting subtest: basic-flip-before-cursor-atomic [132.009881] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.309s) [132.949547] [100/165] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [133.070549] Starting subtest: basic-flip-before-cursor-legacy [134.379057] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.308s) [135.319155] [101/165] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [135.436400] Starting subtest: basic-flip-before-cursor-varying-size [136.747101] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.310s) [137.684875] [102/165] (867s left) kms_dsc (dsc-basic) [137.806026] Subtest dsc-basic: SKIP (0.000s) [137.857711] [103/165] (867s left) kms_flip (basic-flip-vs-dpms) [137.979142] Starting subtest: basic-flip-vs-dpms [137.981462] Starting dynamic subtest: A-eDP1 [140.810356] Dynamic subtest A-eDP1: SUCCESS (2.828s) [140.826777] Starting dynamic subtest: B-eDP1 [143.245840] Dynamic subtest B-eDP1: SUCCESS (2.435s) [143.266091] Starting dynamic subtest: C-eDP1 [145.675434] Dynamic subtest C-eDP1: SUCCESS (2.428s) [145.677875] Subtest basic-flip-vs-dpms: SUCCESS (7.700s) [146.599393] [104/165] (859s left) kms_flip (basic-flip-vs-modeset) [146.722194] Starting subtest: basic-flip-vs-modeset [146.724648] Starting dynamic subtest: A-eDP1 [149.575376] Dynamic subtest A-eDP1: SUCCESS (2.849s) [149.591734] Starting dynamic subtest: B-eDP1 [151.945124] Dynamic subtest B-eDP1: SUCCESS (2.369s) [151.961485] Starting dynamic subtest: C-eDP1 [154.317320] Dynamic subtest C-eDP1: SUCCESS (2.372s) [154.322269] Subtest basic-flip-vs-modeset: SUCCESS (7.599s) [155.289122] [105/165] (850s left) kms_flip (basic-flip-vs-wf_vblank) [155.410740] Starting subtest: basic-flip-vs-wf_vblank [155.414220] Starting dynamic subtest: A-eDP1 [157.743748] Dynamic subtest A-eDP1: SUCCESS (2.328s) [157.766462] Starting dynamic subtest: B-eDP1 [159.968989] Dynamic subtest B-eDP1: SUCCESS (2.223s) [159.987619] Starting dynamic subtest: C-eDP1 [162.209934] Dynamic subtest C-eDP1: SUCCESS (2.239s) [162.215722] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.805s) [163.540637] [106/165] (842s left) kms_flip (basic-plain-flip) [163.662401] Starting subtest: basic-plain-flip [163.665067] Starting dynamic subtest: A-eDP1 [165.718521] Dynamic subtest A-eDP1: SUCCESS (2.053s) [165.742053] Starting dynamic subtest: B-eDP1 [167.683909] Dynamic subtest B-eDP1: SUCCESS (1.963s) [167.703591] Starting dynamic subtest: C-eDP1 [169.666822] Dynamic subtest C-eDP1: SUCCESS (1.980s) [169.672224] Subtest basic-plain-flip: SUCCESS (6.012s) [170.976144] [107/165] (834s left) kms_force_connector_basic (force-connector-state) [171.073167] Starting subtest: force-connector-state [171.667704] Subtest force-connector-state: SUCCESS (0.593s) [172.741543] [108/165] (833s left) kms_force_connector_basic (force-edid) [172.835167] Starting subtest: force-edid [173.097829] Subtest force-edid: SUCCESS (0.263s) [173.218630] [109/165] (832s left) kms_force_connector_basic (force-load-detect) [173.312214] Starting subtest: force-load-detect [173.314708] Subtest force-load-detect: SKIP (0.000s) [173.441169] [110/165] (832s left) kms_force_connector_basic (prune-stale-modes) [173.534129] Starting subtest: prune-stale-modes [173.852415] Subtest prune-stale-modes: SUCCESS (0.318s) [173.987518] [111/165] (831s left) kms_frontbuffer_tracking (basic) [174.115518] Starting subtest: basic [177.522082] Subtest basic: SUCCESS (3.404s) [177.646219] [112/165] (828s left) kms_hdmi_inject (inject-audio) [178.060385] Starting subtest: inject-audio [178.307331] Subtest inject-audio: SUCCESS (0.243s) [179.336264] [113/165] (826s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [179.458434] Starting subtest: compare-crc-sanitycheck-xr24 [179.459615] Starting dynamic subtest: pipe-A-eDP-1 [180.145866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s) [180.166077] Starting dynamic subtest: pipe-B-eDP-1 [181.555218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s) [181.575149] Starting dynamic subtest: pipe-C-eDP-1 [182.939833] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s) [182.940979] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.481s) [183.892834] [114/165] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [184.011831] Starting subtest: compare-crc-sanitycheck-nv12 [184.014665] Starting dynamic subtest: pipe-A-eDP-1 [184.957194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.941s) [184.975348] Starting dynamic subtest: pipe-B-eDP-1 [186.351361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s) [186.370647] Starting dynamic subtest: pipe-C-eDP-1 [187.747145] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s) [187.748351] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.735s) [188.696311] [115/165] (817s left) kms_pipe_crc_basic (hang-read-crc) [188.815517] Starting subtest: hang-read-crc [188.816752] Starting dynamic subtest: pipe-A-eDP-1 [191.236663] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.419s) [191.255178] Starting dynamic subtest: pipe-B-eDP-1 [194.342617] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.102s) [194.361352] Starting dynamic subtest: pipe-C-eDP-1 [197.368274] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.021s) [197.369526] Subtest hang-read-crc: SUCCESS (8.553s) [198.294368] [116/165] (807s left) kms_pipe_crc_basic (nonblocking-crc) [198.429409] Starting subtest: nonblocking-crc [198.430913] Starting dynamic subtest: pipe-A-eDP-1 [199.322566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.894s) [199.339889] Starting dynamic subtest: pipe-B-eDP-1 [200.919562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s) [200.938564] Starting dynamic subtest: pipe-C-eDP-1 [202.466059] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s) [202.467197] Subtest nonblocking-crc: SUCCESS (4.041s) [203.413202] [117/165] (802s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [203.534426] Starting subtest: nonblocking-crc-frame-sequence [203.535546] Starting dynamic subtest: pipe-A-eDP-1 [204.421904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s) [204.440703] Starting dynamic subtest: pipe-B-eDP-1 [206.042564] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.617s) [206.061434] Starting dynamic subtest: pipe-C-eDP-1 [207.621221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.573s) [207.622414] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.087s) [208.556766] [118/165] (797s left) kms_pipe_crc_basic (read-crc) [208.679664] Starting subtest: read-crc [208.682680] Starting dynamic subtest: pipe-A-eDP-1 [209.519054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s) [209.537598] Starting dynamic subtest: pipe-B-eDP-1 [211.043650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.522s) [211.062266] Starting dynamic subtest: pipe-C-eDP-1 [212.561292] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s) [212.562556] Subtest read-crc: SUCCESS (3.883s) [213.522927] [119/165] (792s left) kms_pipe_crc_basic (read-crc-frame-sequence) [213.644402] Starting subtest: read-crc-frame-sequence [213.645611] Starting dynamic subtest: pipe-A-eDP-1 [214.467149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s) [214.485806] Starting dynamic subtest: pipe-B-eDP-1 [216.037531] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.567s) [216.056765] Starting dynamic subtest: pipe-C-eDP-1 [217.553770] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.512s) [217.555019] Subtest read-crc-frame-sequence: SUCCESS (3.911s) [218.518055] [120/165] (787s left) kms_pm_backlight (basic-brightness) [218.639257] Starting subtest: basic-brightness [218.744134] Starting dynamic subtest: eDP-1 [219.271997] Dynamic subtest eDP-1: SUCCESS (0.527s) [219.275978] Subtest basic-brightness: SUCCESS (0.633s) [220.250194] [121/165] (785s left) kms_pm_rpm (basic-pci-d3-state) [222.098145] Starting subtest: basic-pci-d3-state [226.476930] Subtest basic-pci-d3-state: SUCCESS (4.377s) [226.681466] [122/165] (779s left) kms_pm_rpm (basic-rte) [226.771496] Starting subtest: basic-rte [232.877498] Subtest basic-rte: SUCCESS (6.105s) [234.381227] [123/165] (771s left) kms_psr (psr-primary-page-flip) [234.505488] Starting subtest: psr-primary-page-flip [234.506694] Starting dynamic subtest: eDP-1 [238.341939] Dynamic subtest eDP-1: SUCCESS (3.834s) [238.343488] Subtest psr-primary-page-flip: SUCCESS (3.837s) [239.316356] [124/165] (766s left) kms_psr (psr-cursor-plane-move) [239.438046] Starting subtest: psr-cursor-plane-move [239.441422] Starting dynamic subtest: eDP-1 [243.245111] Dynamic subtest eDP-1: SUCCESS (3.805s) [243.246210] Subtest psr-cursor-plane-move: SUCCESS (3.808s) [244.181737] [125/165] (762s left) kms_psr (psr-sprite-plane-onoff) [244.302426] Starting subtest: psr-sprite-plane-onoff [244.303691] Starting dynamic subtest: eDP-1 [248.214682] Dynamic subtest eDP-1: SUCCESS (3.906s) [248.215898] Subtest psr-sprite-plane-onoff: SUCCESS (3.908s) [249.176574] [126/165] (757s left) kms_psr (psr-primary-mmap-gtt) [249.296735] Starting subtest: psr-primary-mmap-gtt [249.300189] Starting dynamic subtest: eDP-1 [253.215030] Dynamic subtest eDP-1: SUCCESS (3.911s) [253.216268] Subtest psr-primary-mmap-gtt: SUCCESS (3.914s) [254.166797] [127/165] (752s left) kms_setmode (basic-clone-single-crtc) [254.259547] Starting subtest: basic-clone-single-crtc [254.262936] Subtest basic-clone-single-crtc: SKIP (0.000s) [254.347563] [128/165] (752s left) i915_pm_rps (basic-api) [254.445747] Starting subtest: basic-api [254.450301] Subtest basic-api: SUCCESS (0.005s) [254.548922] [129/165] (751s left) prime_self_import (basic-llseek-bad) [254.639803] Starting subtest: basic-llseek-bad [254.642204] Subtest basic-llseek-bad: SUCCESS (0.003s) [254.735562] [130/165] (751s left) prime_self_import (basic-llseek-size) [254.823081] Starting subtest: basic-llseek-size [254.827634] Subtest basic-llseek-size: SUCCESS (0.004s) [254.933930] [131/165] (751s left) prime_self_import (basic-with_fd_dup) [255.020358] Starting subtest: basic-with_fd_dup [255.025092] Subtest basic-with_fd_dup: SUCCESS (0.005s) [255.135095] [132/165] (751s left) prime_self_import (basic-with_one_bo) [255.224908] Starting subtest: basic-with_one_bo [255.229616] Subtest basic-with_one_bo: SUCCESS (0.005s) [255.314278] [133/165] (751s left) prime_self_import (basic-with_one_bo_two_files) [255.401635] Starting subtest: basic-with_one_bo_two_files [255.406321] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [255.500129] [134/165] (751s left) prime_self_import (basic-with_two_bos) [255.587314] Starting subtest: basic-with_two_bos [255.591919] Subtest basic-with_two_bos: SUCCESS (0.005s) [255.702722] [135/165] (750s left) prime_vgem (basic-fence-flip) [255.821573] Starting subtest: basic-fence-flip [256.357017] Subtest basic-fence-flip: SUCCESS (0.535s) [256.470059] [136/165] (750s left) prime_vgem (basic-fence-mmap) [256.589278] Starting subtest: basic-fence-mmap [256.639169] Subtest basic-fence-mmap: SUCCESS (0.050s) [256.736786] [137/165] (749s left) prime_vgem (basic-fence-read) [256.861697] Starting subtest: basic-fence-read [256.937777] Subtest basic-fence-read: SUCCESS (0.076s) [257.036529] [138/165] (749s left) prime_vgem (basic-gtt) [257.152124] Starting subtest: basic-gtt [257.174778] Subtest basic-gtt: SUCCESS (0.024s) [257.289093] [139/165] (749s left) prime_vgem (basic-read) [257.412058] Starting subtest: basic-read [257.449257] Subtest basic-read: SUCCESS (0.037s) [257.569764] [140/165] (749s left) prime_vgem (basic-write) [257.683977] Starting subtest: basic-write [257.727964] Subtest basic-write: SUCCESS (0.044s) [257.816726] [141/165] (749s left) vgem_basic (setversion) [257.909855] Starting subtest: setversion [257.912299] Subtest setversion: SUCCESS (0.000s) [257.982249] [142/165] (748s left) vgem_basic (create) [258.076744] Starting subtest: create [258.078226] Subtest create: SUCCESS (0.000s) [258.153117] [143/165] (748s left) vgem_basic (debugfs) [258.260497] Starting subtest: debugfs [258.261819] Subtest debugfs: SUCCESS (0.001s) [258.335987] [144/165] (748s left) vgem_basic (dmabuf-export) [258.444377] Starting subtest: dmabuf-export [258.449305] Subtest dmabuf-export: SUCCESS (0.003s) [258.553444] [145/165] (748s left) vgem_basic (dmabuf-fence) [258.661148] Starting subtest: dmabuf-fence [258.662650] Subtest dmabuf-fence: SUCCESS (0.001s) [258.738644] [146/165] (748s left) vgem_basic (dmabuf-fence-before) [258.844462] Starting subtest: dmabuf-fence-before [258.845702] Subtest dmabuf-fence-before: SUCCESS (0.001s) [258.923919] [147/165] (748s left) vgem_basic (dmabuf-mmap) [259.027647] Starting subtest: dmabuf-mmap [259.052897] Subtest dmabuf-mmap: SUCCESS (0.025s) [259.117323] [148/165] (747s left) vgem_basic (mmap) [259.211454] Starting subtest: mmap [259.227900] Subtest mmap: SUCCESS (0.017s) [259.300713] [149/165] (747s left) vgem_basic (second-client) [259.394477] Starting subtest: second-client [259.429524] Subtest second-client: SUCCESS (0.033s) [259.507607] [150/165] (747s left) vgem_basic (sysfs) [259.614245] Starting subtest: sysfs [259.615445] Subtest sysfs: SUCCESS (0.001s) [259.688392] [151/165] (747s left) core_hotunplug (unbind-rebind) [259.828482] Starting subtest: unbind-rebind [264.259327] Subtest unbind-rebind: SUCCESS (4.431s) [264.296048] [152/165] (742s left) vgem_basic (unload) [264.390653] Starting subtest: unload [293.464651] Subtest unload: SUCCESS (29.039s) [293.551291] [153/165] (713s left) i915_module_load (reload) [293.641096] Starting subtest: reload [296.967843] Subtest reload: SUCCESS (3.327s) [296.998334] [154/165] (710s left) gem_lmem_swapping (basic) [297.107968] Subtest basic: SKIP (0.000s) [297.155486] [155/165] (710s left) gem_lmem_swapping (parallel-random-engines) [297.251975] Subtest parallel-random-engines: SKIP (0.000s) [297.303074] [156/165] (709s left) gem_lmem_swapping (random-engines) [297.401593] Subtest random-engines: SKIP (0.000s) [297.453603] [157/165] (709s left) gem_lmem_swapping (verify-random) [297.549620] Subtest verify-random: SKIP (0.000s) [297.603952] [158/165] (709s left) i915_pm_rpm (module-reload) [310.075387] Starting subtest: module-reload [339.358213] Subtest module-reload: SUCCESS (29.278s) [339.380990] [159/165] (667s left) i915_selftest (live) [339.482084] Starting subtest: live [339.483392] Starting dynamic subtest: sanitycheck [341.359102] Dynamic subtest sanitycheck: SUCCESS (1.867s) [341.374216] Starting dynamic subtest: uncore [343.171704] Dynamic subtest uncore: SUCCESS (1.809s) [343.186896] Starting dynamic subtest: workarounds [345.265110] Dynamic subtest workarounds: SUCCESS (2.090s) [345.280364] Starting dynamic subtest: gt_engines [347.563500] Dynamic subtest gt_engines: SUCCESS (2.295s) [347.578622] Starting dynamic subtest: gt_timelines [360.168559] Dynamic subtest gt_timelines: SUCCESS (12.602s) [360.183387] Starting dynamic subtest: gt_contexts [362.143579] Dynamic subtest gt_contexts: SUCCESS (1.971s) [362.158813] Starting dynamic subtest: gt_lrc [366.521100] Dynamic subtest gt_lrc: SUCCESS (4.374s) [366.536327] Starting dynamic subtest: gt_mocs [368.433721] Dynamic subtest gt_mocs: SUCCESS (1.913s) [368.448510] Starting dynamic subtest: gt_pm [373.534768] Dynamic subtest gt_pm: SUCCESS (5.094s) [373.549579] Starting dynamic subtest: gt_heartbeat [375.469368] Dynamic subtest gt_heartbeat: SUCCESS (1.939s) [375.488537] Starting dynamic subtest: gt_tlb [378.604809] Dynamic subtest gt_tlb: SUCCESS (3.123s) [378.619614] Starting dynamic subtest: requests [386.203693] Dynamic subtest requests: SUCCESS (7.595s) [386.218676] Starting dynamic subtest: migrate [390.803980] Dynamic subtest migrate: SUCCESS (4.597s) [390.818921] Starting dynamic subtest: active [392.691579] Dynamic subtest active: SUCCESS (1.884s) [392.706757] Starting dynamic subtest: objects [396.064643] Dynamic subtest objects: SUCCESS (3.370s) [396.079961] Starting dynamic subtest: mman [403.015648] Dynamic subtest mman: SUCCESS (6.947s) [403.031027] Starting dynamic subtest: dmabuf [404.928493] Dynamic subtest dmabuf: SUCCESS (1.910s) [404.943702] Starting dynamic subtest: vma [406.780346] Dynamic subtest vma: SUCCESS (1.848s) [406.795650] Starting dynamic subtest: coherency [413.290380] Dynamic subtest coherency: SUCCESS (6.506s) [413.305615] Starting dynamic subtest: gtt [422.736780] Dynamic subtest gtt: SUCCESS (9.443s) [422.751787] Starting dynamic subtest: gem [424.769688] Dynamic subtest gem: SUCCESS (2.029s) [424.784842] Starting dynamic subtest: evict [428.578647] Dynamic subtest evict: SUCCESS (3.805s) [428.593780] Starting dynamic subtest: hugepages [436.320602] Dynamic subtest hugepages: SUCCESS (7.738s) [436.336079] Starting dynamic subtest: gem_contexts [451.679754] Dynamic subtest gem_contexts: SUCCESS (15.355s) [451.695067] Starting dynamic subtest: client [453.556972] Dynamic subtest client: SUCCESS (1.873s) [453.573339] Starting dynamic subtest: gem_migrate [455.414179] Dynamic subtest gem_migrate: SUCCESS (1.854s) [455.429910] Starting dynamic subtest: reset [460.743546] Dynamic subtest reset: SUCCESS (5.327s) [460.759089] Starting dynamic subtest: memory_region [462.591311] Dynamic subtest memory_region: SUCCESS (1.844s) [462.607115] Starting dynamic subtest: hangcheck [486.986836] Dynamic subtest hangcheck: SUCCESS (24.392s) [487.002321] Starting dynamic subtest: execlists [497.054052] Dynamic subtest execlists: SUCCESS (10.063s) [497.069403] Starting dynamic subtest: ring_submission [498.922599] Dynamic subtest ring_submission: SUCCESS (1.865s) [498.938379] Starting dynamic subtest: perf [500.843625] Dynamic subtest perf: SUCCESS (1.918s) [500.859332] Starting dynamic subtest: slpc [502.687336] Dynamic subtest slpc: SUCCESS (1.841s) [502.703086] Starting dynamic subtest: guc [504.563094] Dynamic subtest guc: SUCCESS (1.873s) [504.578478] Starting dynamic subtest: guc_multi_lrc [506.421493] Dynamic subtest guc_multi_lrc: SUCCESS (1.855s) [506.437281] Starting dynamic subtest: guc_hang [508.272414] Dynamic subtest guc_hang: SUCCESS (1.848s) [508.288154] Starting dynamic subtest: late_gt_pm [510.125346] Dynamic subtest late_gt_pm: SUCCESS (1.850s) [510.126550] Subtest live: SUCCESS (170.636s) [510.151425] [160/165] (497s left) dmabuf (all-tests) [510.247720] Starting subtest: all-tests [510.250940] Starting dynamic subtest: sanitycheck [510.315858] Dynamic subtest sanitycheck: SUCCESS (0.066s) [510.335263] Starting dynamic subtest: dma_fence [510.511913] Dynamic subtest dma_fence: SUCCESS (0.192s) [510.530261] Starting dynamic subtest: dma_fence_chain [528.083088] Dynamic subtest dma_fence_chain: SUCCESS (17.559s) [528.096543] Starting dynamic subtest: dma_fence_unwrap [528.146758] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s) [528.166794] Starting dynamic subtest: dma_resv [528.219750] Dynamic subtest dma_resv: SUCCESS (0.069s) [528.222100] Subtest all-tests: SUCCESS (17.973s) [528.253352] [161/165] (479s left) i915_suspend (basic-s2idle-without-i915) [528.341415] Starting subtest: basic-s2idle-without-i915 [552.020325] Subtest basic-s2idle-without-i915: SUCCESS (8.447s) [552.090629] [162/165] (470s left) i915_suspend (basic-s3-without-i915) [552.179194] Starting subtest: basic-s3-without-i915 [576.080520] Subtest basic-s3-without-i915: SUCCESS (7.265s) [576.136811] [163/165] (463s left) gem_exec_suspend (basic-s0) [576.252089] Starting subtest: basic-S0 [576.253225] Starting dynamic subtest: smem [595.969219] Dynamic subtest smem: SUCCESS (3.835s) [595.970647] Subtest basic-S0: SUCCESS (3.837s) [596.180336] [164/165] (459s left) gem_exec_suspend (basic-s3) [596.287617] Starting subtest: basic-S3 [596.288742] Starting dynamic subtest: smem [614.914904] Dynamic subtest smem: SUCCESS (3.655s) [614.916254] Subtest basic-S3: SUCCESS (3.657s) [615.125005] [165/165] (455s left) kms_pipe_crc_basic (suspend-read-crc) [615.248755] Starting subtest: suspend-read-crc [615.252316] Starting dynamic subtest: pipe-A-eDP-1 [632.898247] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.491s) [632.920121] Starting dynamic subtest: pipe-B-eDP-1 [651.858816] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.174s) [651.881135] Starting dynamic subtest: pipe-C-eDP-1 [669.863095] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.100s) [669.864300] Subtest suspend-read-crc: SUCCESS (8.779s) [670.784817] Closing watchdogs Done.