Bug 103027

Summary: [BAT] igt@kms_addfb_basic@tile-pitch-mismatch incomplete
Product: DRI Reporter: Jani Saarinen <jani.saarinen>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: CLOSED DUPLICATE QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: major    
Priority: high CC: intel-gfx-bugs
Version: DRI git   
Hardware: Other   
OS: All   
Whiteboard: ReadyForDev
i915 platform: CNL i915 features: GEM/execlists

Description Jani Saarinen 2017-09-28 15:08:19 UTC
On CI_DRM_3150 cnl got incomplete on igt@kms_addfb_basic@tile-pitch-mismatch

https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3150/fi-cnl-y/igt@kms_addfb_basic@tile-pitch-mismatch.html

Oops:
<7>[  299.442294] [drm:intel_set_cdclk [i915]] Changing CDCLK to 336000 kHz, VCO 672000 kHz, ref 24000 kHz
<7>[  299.442484] [drm:intel_update_cdclk [i915]] Current CD clock rate: 336000 kHz, VCO: 672000 kHz, ref: 24000 kHz
<7>[  299.442507] [drm:intel_atomic_commit_tail [i915]] [ENCODER:75:DDI A]
<7>[  299.442528] [drm:intel_atomic_commit_tail [i915]] [ENCODER:86:DDI B]
<7>[  299.442549] [drm:intel_atomic_commit_tail [i915]] [ENCODER:88:DP-MST A]
<7>[  299.442570] [drm:intel_atomic_commit_tail [i915]] [ENCODER:89:DP-MST B]
<7>[  299.442590] [drm:intel_atomic_commit_tail [i915]] [ENCODER:90:DP-MST C]
<7>[  299.442610] [drm:intel_atomic_commit_tail [i915]] [ENCODER:91:DDI C]
<7>[  299.442630] [drm:intel_atomic_commit_tail [i915]] [ENCODER:94:DDI D]
<7>[  299.442650] [drm:intel_atomic_commit_tail [i915]] [ENCODER:96:DP-MST A]
<7>[  299.442670] [drm:intel_atomic_commit_tail [i915]] [ENCODER:97:DP-MST B]
<7>[  299.442690] [drm:intel_atomic_commit_tail [i915]] [ENCODER:98:DP-MST C]
<7>[  299.442710] [drm:verify_connector_state.isra.72 [i915]] [CONNECTOR:87:DP-1]
<7>[  299.442733] [drm:verify_connector_state.isra.72 [i915]] [CONNECTOR:92:HDMI-A-1]
<7>[  299.442755] [drm:verify_connector_state.isra.72 [i915]] [CONNECTOR:95:DP-2]
<7>[  299.442776] [drm:verify_single_dpll_state.isra.73 [i915]] DPLL 0
<7>[  299.442796] [drm:verify_single_dpll_state.isra.73 [i915]] DPLL 1
<7>[  299.442816] [drm:verify_single_dpll_state.isra.73 [i915]] DPLL 2
<7>[  299.442842] [drm:intel_enable_shared_dpll [i915]] enable DPLL 0 (active 1, on? 0) for crtc 42
<7>[  299.442864] [drm:intel_enable_shared_dpll [i915]] enabling DPLL 0
<7>[  299.444960] [drm:edp_panel_on [i915]] Turn eDP port A panel power on
<7>[  299.445037] [drm:wait_panel_power_cycle [i915]] Wait for panel power cycle
<7>[  299.445325] [drm:wait_panel_status [i915]] mask b800000f value 00000000 status 00000000 control 00000060
<7>[  299.445387] [drm:wait_panel_status [i915]] Wait complete
<7>[  299.445522] [drm:edp_panel_on [i915]] Wait for panel power on
<7>[  299.445777] [drm:wait_panel_status [i915]] mask b000000f value 80000008 status 9000000a control 00000063
<7>[  299.536063] [drm:intel_get_hpd_pins [i915]] hotplug event received, stat 0x01000000, dig 0x12101010, pins 0x00000010
<7>[  299.536099] [drm:intel_hpd_irq_handler [i915]] digital hpd port A - long
<7>[  299.536131] [drm:intel_hpd_irq_handler [i915]] Received HPD interrupt on PIN 4 - cnt: 0
<7>[  299.536211] [drm:intel_dp_hpd_pulse [i915]] ignoring long hpd on eDP port A
<7>[  299.606589] [drm:wait_panel_status [i915]] Wait complete
<7>[  299.606769] [drm:edp_panel_vdd_on [i915]] Turning eDP port A VDD on
<7>[  299.607065] [drm:edp_panel_vdd_on [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x0000006b
<7>[  299.608861] [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7>[  299.608913] [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 0
<7>[  299.608980] [drm:intel_dp_program_link_training_pattern [i915]] Using DP training pattern TPS1
<7>[  299.614000] [drm:intel_dp_set_signal_levels [i915]] Using vswing level 0
<7>[  299.614019] [drm:intel_dp_set_signal_levels [i915]] Using pre-emphasis level 1
<7>[  299.618947] [drm:intel_dp_start_link_train [i915]] clock recovery OK
<7>[  299.618967] [drm:intel_dp_program_link_training_pattern [i915]] Using DP training pattern TPS2
<7>[  299.623904] [drm:intel_dp_start_link_train [i915]] Channel EQ done. DP Training successful
<7>[  299.623925] [drm:intel_dp_start_link_train [i915]] [CONNECTOR:76:eDP-1] Link Training Passed at Link Rate = 270000, Lane count = 4
<7>[  299.624439] [drm:intel_enable_pipe [i915]] enabling pipe A
<7>[  299.624468] [drm:intel_edp_backlight_on [i915]] 
<7>[  299.624490] [drm:intel_panel_enable_backlight [i915]] pipe A
<7>[  299.624584] [drm:intel_panel_actually_set_backlight [i915]] set backlight PWM = 120000
<7>[  299.624849] [drm:intel_psr_enable [i915]] PSR disable by flag
<7>[  299.624878] [drm:intel_fbc_enable [i915]] reserved 29491200 bytes of contiguous stolen space for FBC, threshold: 1
<7>[  299.624908] [drm:intel_fbc_enable [i915]] Enabling FBC on pipe A
<7>[  299.645537] [drm:verify_connector_state.isra.72 [i915]] [CONNECTOR:76:eDP-1]
<7>[  299.645601] [drm:intel_atomic_commit_tail [i915]] [CRTC:42:pipe A]
<7>[  299.645690] [drm:verify_single_dpll_state.isra.73 [i915]] DPLL 0
<7>[  299.645751] [drm:intel_atomic_commit_tail [i915]] [CRTC:58:pipe B]
<7>[  299.645811] [drm:intel_atomic_commit_tail [i915]] [CRTC:74:pipe C]
<7>[  299.646357] [drm:intel_dp_detect [i915]] [CONNECTOR:76:eDP-1]
<7>[  299.646416] [drm:intel_dp_print_rates [i915]] source rates: 162000, 216000, 270000, 324000, 432000, 540000
<7>[  299.646468] [drm:intel_dp_print_rates [i915]] sink rates: 162000, 270000
<7>[  299.646518] [drm:intel_dp_print_rates [i915]] common rates: 162000, 270000
<7>[  299.646687] [drm:intel_opregion_register [i915]] 4 outputs detected
<7>[  299.649062] [drm:drm_dp_read_desc] DP sink: OUI 34-f6-2d dev-ID  HW-rev 0.0 SW-rev 0.0 quirks 0x0000
<7>[  299.650145] [drm:drm_helper_hpd_irq_event] [CONNECTOR:76:eDP-1] status updated from connected to connected
<7>[  299.650227] [drm:intel_dp_detect [i915]] [CONNECTOR:87:DP-1]
<7>[  299.650280] [drm:drm_helper_hpd_irq_event] [CONNECTOR:87:DP-1] status updated from disconnected to disconnected
<7>[  299.650362] [drm:intel_hdmi_detect [i915]] [CONNECTOR:92:HDMI-A-1]
<7>[  299.650919] [drm:gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7>[  299.651011] [drm:gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7>[  299.651558] [drm:gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0050 w(1)
<7>[  299.651566] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus dpc
<7>[  299.652115] [drm:gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0040 w(1)
<7>[  299.652188] [drm:gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK on first message, retry
<7>[  299.652739] [drm:gmbus_xfer [i915]] GMBUS [i915 gmbus dpc] NAK for addr: 0040 w(1)
<7>[  299.652749] [drm:drm_dp_dual_mode_detect] DP dual mode HDMI ID:  (err -6)
<7>[  299.652758] [drm:drm_helper_hpd_irq_event] [CONNECTOR:92:HDMI-A-1] status updated from disconnected to disconnected
<7>[  299.652828] [drm:intel_dp_detect [i915]] [CONNECTOR:95:DP-2]
<7>[  299.652891] [drm:drm_helper_hpd_irq_event] [CONNECTOR:95:DP-2] status updated from disconnected to disconnected
<3>[  299.670959] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0
<6>[  299.769218] usb 1-6: reset high-speed USB device number 3 using xhci_hcd
<6>[  300.011178] usb 1-4: reset high-speed USB device number 2 using xhci_hcd
<3>[  300.046782] atkbd serio0: Failed to enable keyboard on isa0060/serio0
<6>[  300.478159] sdhci-pci 0000:00:14.5: SDHCI controller found [8086:9df5] (rev 11)
<6>[  300.487753] acpi LNXPOWER:0a: Turning OFF
<7>[  300.500035] PM: Basic memory bitmaps freed
<6>[  300.500042] OOM killer enabled.
<6>[  300.500046] Restarting tasks ... done.
<6>[  300.534854] PM: hibernation exit
<6>[  300.535139] [drm] RC6 on
<7>[  300.646902] [drm:intel_dp_set_drrs_state.isra.18 [i915]] eDP Refresh Rate set to : 48Hz
<4>[  301.006619] Setting dangerous option reset - tainting kernel
<14>[  301.006707] [IGT] gem_exec_suspend: exiting, ret=0
<7>[  301.021755] [drm:intel_dp_set_drrs_state.isra.18 [i915]] eDP Refresh Rate set to : 60Hz
<14>[  301.084447] [IGT] gem_flink_basic: executing
<14>[  301.107460] [IGT] gem_flink_basic: starting subtest bad-flink
<14>[  301.107519] [IGT] gem_flink_basic: exiting, ret=0
<14>[  301.179229] [IGT] gem_flink_basic: executing
<14>[  301.194456] [IGT] gem_flink_basic: starting subtest bad-open
<14>[  301.194514] [IGT] gem_flink_basic: exiting, ret=0
<14>[  301.257346] [IGT] gem_flink_basic: executing
<14>[  301.277304] [IGT] gem_flink_basic: starting subtest basic
<14>[  301.277394] [IGT] gem_flink_basic: exiting, ret=0
<14>[  301.349052] [IGT] gem_flink_basic: executing
<14>[  301.361394] [IGT] gem_flink_basic: starting subtest double-flink
<14>[  301.361491] [IGT] gem_flink_basic: exiting, ret=0
<14>[  301.422915] [IGT] gem_flink_basic: executing
<14>[  301.438580] [IGT] gem_flink_basic: starting subtest flink-lifetime
<14>[  301.439111] [IGT] gem_flink_basic: exiting, ret=0
<14>[  301.527018] [IGT] gem_linear_blits: executing
<14>[  301.559475] [IGT] gem_linear_blits: starting subtest basic
<14>[  301.578675] [IGT] gem_linear_blits: exiting, ret=0
<14>[  301.663323] [IGT] gem_mmap: executing
<14>[  301.676067] [IGT] gem_mmap: starting subtest basic
<14>[  301.676207] [IGT] gem_mmap: exiting, ret=0
<14>[  301.765172] [IGT] gem_mmap: executing
<14>[  301.780052] [IGT] gem_mmap: starting subtest basic-small-bo
<14>[  301.918175] [IGT] gem_mmap: exiting, ret=0
<14>[  302.145908] [IGT] gem_mmap_gtt: executing
<14>[  302.175027] [IGT] gem_mmap_gtt: starting subtest basic
<14>[  302.175423] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  302.246696] [IGT] gem_mmap_gtt: executing
<14>[  302.262111] [IGT] gem_mmap_gtt: starting subtest basic-copy
<6>[  302.384725] asix 1-4:1.0 enx00106031d5f8: link up, 100Mbps, full-duplex, lpa 0xC1E1
<14>[  302.515423] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  302.667121] [IGT] gem_mmap_gtt: executing
<7>[  302.693489] [drm:edp_panel_vdd_off_sync [i915]] Turning eDP port A VDD off
<7>[  302.693858] [drm:edp_panel_vdd_off_sync [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<14>[  302.722711] [IGT] gem_mmap_gtt: starting subtest basic-read
<14>[  302.748279] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  302.913443] [IGT] gem_mmap_gtt: executing
<14>[  302.937499] [IGT] gem_mmap_gtt: starting subtest basic-read-no-prefault
<4>[  302.937586] Setting dangerous option prefault_disable - tainting kernel
<4>[  302.956380] Setting dangerous option prefault_disable - tainting kernel
<14>[  302.956498] [IGT] gem_mmap_gtt: exiting, ret=0
<4>[  302.956562] Setting dangerous option prefault_disable - tainting kernel
<14>[  303.033964] [IGT] gem_mmap_gtt: executing
<14>[  303.048501] [IGT] gem_mmap_gtt: starting subtest basic-read-write
<14>[  303.054279] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  303.144636] [IGT] gem_mmap_gtt: executing
<14>[  303.170258] [IGT] gem_mmap_gtt: starting subtest basic-read-write-distinct
<14>[  303.178913] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  303.274161] [IGT] gem_mmap_gtt: executing
<14>[  303.293265] [IGT] gem_mmap_gtt: starting subtest basic-short
<14>[  303.313447] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  303.386129] [IGT] gem_mmap_gtt: executing
<14>[  303.399223] [IGT] gem_mmap_gtt: starting subtest basic-small-bo
<14>[  303.461383] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  303.657280] [IGT] gem_mmap_gtt: executing
<14>[  303.682237] [IGT] gem_mmap_gtt: starting subtest basic-small-bo-tiledX
<14>[  303.747374] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  303.940034] [IGT] gem_mmap_gtt: executing
<14>[  303.962326] [IGT] gem_mmap_gtt: starting subtest basic-small-bo-tiledY
<14>[  304.028149] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  304.228497] [IGT] gem_mmap_gtt: executing
<14>[  304.255944] [IGT] gem_mmap_gtt: starting subtest basic-small-copy
<14>[  305.925067] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  306.090789] [IGT] gem_mmap_gtt: executing
<14>[  306.121030] [IGT] gem_mmap_gtt: starting subtest basic-small-copy-XY
<14>[  308.245913] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  308.406805] [IGT] gem_mmap_gtt: executing
<14>[  308.433848] [IGT] gem_mmap_gtt: starting subtest basic-wc
<14>[  309.063509] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  309.128885] [IGT] gem_mmap_gtt: executing
<14>[  309.155365] [IGT] gem_mmap_gtt: starting subtest basic-write
<14>[  309.387687] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  309.467417] [IGT] gem_mmap_gtt: executing
<14>[  309.489174] [IGT] gem_mmap_gtt: starting subtest basic-write-cpu-read-gtt
<14>[  309.924043] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  310.017750] [IGT] gem_mmap_gtt: executing
<14>[  310.031271] [IGT] gem_mmap_gtt: starting subtest basic-write-gtt
<14>[  310.262497] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  310.341403] [IGT] gem_mmap_gtt: executing
<14>[  310.360886] [IGT] gem_mmap_gtt: starting subtest basic-write-gtt-no-prefault
<4>[  310.361048] Setting dangerous option prefault_disable - tainting kernel
<4>[  310.599061] Setting dangerous option prefault_disable - tainting kernel
<14>[  310.599172] [IGT] gem_mmap_gtt: exiting, ret=0
<4>[  310.599243] Setting dangerous option prefault_disable - tainting kernel
<14>[  310.686018] [IGT] gem_mmap_gtt: executing
<14>[  310.699642] [IGT] gem_mmap_gtt: starting subtest basic-write-no-prefault
<4>[  310.699691] Setting dangerous option prefault_disable - tainting kernel
<4>[  310.928079] Setting dangerous option prefault_disable - tainting kernel
<14>[  310.928172] [IGT] gem_mmap_gtt: exiting, ret=0
<4>[  310.928275] Setting dangerous option prefault_disable - tainting kernel
<14>[  311.012693] [IGT] gem_mmap_gtt: executing
<14>[  311.047519] [IGT] gem_mmap_gtt: starting subtest basic-write-read
<14>[  311.061498] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  311.143622] [IGT] gem_mmap_gtt: executing
<14>[  311.160355] [IGT] gem_mmap_gtt: starting subtest basic-write-read-distinct
<14>[  311.167748] [IGT] gem_mmap_gtt: exiting, ret=0
<14>[  311.252179] [IGT] gem_pread: executing
<14>[  311.264336] [IGT] gem_pread: starting subtest basic
<14>[  311.759885] [IGT] gem_pread: exiting, ret=0
<14>[  311.840342] [IGT] gem_pwrite: executing
<14>[  311.854147] [IGT] gem_pwrite: starting subtest basic
<14>[  312.322094] [IGT] gem_pwrite: exiting, ret=0
<14>[  312.407976] [IGT] gem_render_linear_blits: executing
<14>[  312.437012] [IGT] gem_render_linear_blits: starting subtest basic
<14>[  312.459219] [IGT] gem_render_linear_blits: exiting, ret=0
<14>[  312.562874] [IGT] gem_render_tiled_blits: executing
<14>[  312.590955] [IGT] gem_render_tiled_blits: starting subtest basic
<14>[  312.609905] [IGT] gem_render_tiled_blits: exiting, ret=0
<14>[  312.718832] [IGT] gem_ringfill: executing
<6>[  312.778245] [drm] Initialized vgem 1.0.0 20120112 for virtual device on minor 1
<7>[  312.778794] [drm:vgem_gem_dumb_create [vgem]] Created object of size 1
<14>[  312.787373] [IGT] gem_ringfill: starting subtest basic-default
<14>[  312.818544] [IGT] gem_ringfill: exiting, ret=0
<14>[  312.911568] [IGT] gem_ringfill: executing
<7>[  312.970416] [drm:vgem_gem_dumb_create [vgem]] Created object of size 1
<14>[  312.972784] [IGT] gem_ringfill: starting subtest basic-default-interruptible
<14>[  314.319976] [IGT] gem_ringfill: exiting, ret=0
<14>[  314.399227] [IGT] gem_ringfill: executing
<7>[  314.438168] [drm:vgem_gem_dumb_create [vgem]] Created object of size 1
<14>[  314.445519] [IGT] gem_ringfill: starting subtest basic-default-forked
<14>[  314.490904] [IGT] gem_ringfill: exiting, ret=0
<14>[  314.568482] [IGT] gem_ringfill: executing
<7>[  314.600133] [drm:vgem_gem_dumb_create [vgem]] Created object of size 1
<14>[  314.607084] [IGT] gem_ringfill: starting subtest basic-default-fd
<14>[  314.647913] [IGT] gem_ringfill: exiting, ret=0
<14>[  314.729856] [IGT] gem_ringfill: executing
<7>[  314.756865] [drm:vgem_gem_dumb_create [vgem]] Created object of size 1
<14>[  314.763420] [IGT] gem_ringfill: starting subtest basic-default-hang
<7>[  318.621621] [drm:missed_breadcrumb [i915]] rcs0 missed breadcrumb at intel_breadcrumbs_hangcheck+0x61/0x80 [i915], irq posted? yes, current seqno=a97a3, last=a983c
<6>[  321.570271] [drm] GPU HANG: ecode 10:0:0xe757fffe, in gem_ringfill [3512], reason: Hang on rcs0, action: reset
<5>[  321.570328] i915 0000:00:02.0: Resetting rcs0 after gpu hang
<7>[  321.570397] [drm:i915_gem_reset_engine [i915]] context gem_ringfill[3512]/0 marked guilty (score 10) banned? no
<7>[  321.570430] [drm:i915_gem_reset_engine [i915]] resetting rcs0 to restart from tail of request 0xa97a4
<7>[  321.570567] [drm:gen8_init_common_ring [i915]] Execlists enabled for rcs0
<7>[  321.570601] [drm:init_workarounds_ring [i915]] rcs0: Number of context specific w/a: 5
<14>[  325.573372] [IGT] gem_ringfill: exiting, ret=0
<14>[  325.674484] [IGT] gem_sync: executing
<4>[  325.701598] Setting dangerous option reset - tainting kernel
<14>[  325.702861] [IGT] gem_sync: starting subtest basic-all
<14>[  330.805624] [IGT] gem_sync: exiting, ret=0
<14>[  330.892119] [IGT] gem_sync: executing
<4>[  330.933344] Setting dangerous option reset - tainting kernel
<14>[  330.935174] [IGT] gem_sync: starting subtest basic-each
<14>[  336.052021] [IGT] gem_sync: exiting, ret=0
<14>[  336.177618] [IGT] gem_sync: executing
<4>[  336.203637] Setting dangerous option reset - tainting kernel
<14>[  336.205473] [IGT] gem_sync: starting subtest basic-many-each
<14>[  341.902329] [IGT] gem_sync: exiting, ret=0
<14>[  342.034612] [IGT] gem_sync: executing
<4>[  342.074626] Setting dangerous option reset - tainting kernel
<14>[  342.076444] [IGT] gem_sync: starting subtest basic-store-all
<14>[  348.100941] [IGT] gem_sync: exiting, ret=0
<14>[  348.198579] [IGT] gem_sync: executing
<4>[  348.216067] Setting dangerous option reset - tainting kernel
<14>[  348.216853] [IGT] gem_sync: starting subtest basic-store-each
<14>[  353.683273] [IGT] gem_sync: exiting, ret=0
<14>[  353.776044] [IGT] gem_tiled_blits: executing
<14>[  353.818454] [IGT] gem_tiled_blits: starting subtest basic
<14>[  353.839533] [IGT] gem_tiled_blits: exiting, ret=0
<14>[  353.946224] [IGT] gem_tiled_fence_blits: executing
<14>[  353.960095] [IGT] gem_tiled_fence_blits: starting subtest basic
<14>[  353.966531] [IGT] gem_tiled_fence_blits: exiting, ret=0
<14>[  354.074239] [IGT] gem_tiled_pread_basic: executing
<14>[  354.193500] [IGT] gem_tiled_pread_basic: exiting, ret=0
<14>[  354.280054] [IGT] gem_wait: executing
<4>[  354.308270] Setting dangerous option reset - tainting kernel
<14>[  354.311926] [IGT] gem_wait: starting subtest basic-busy-all
<4>[  354.823635] Setting dangerous option reset - tainting kernel
<14>[  354.825392] [IGT] gem_wait: exiting, ret=0
<14>[  354.909146] [IGT] gem_wait: executing
<4>[  354.925796] Setting dangerous option reset - tainting kernel
<14>[  354.927253] [IGT] gem_wait: starting subtest basic-wait-all
<4>[  355.950397] Setting dangerous option reset - tainting kernel
<14>[  355.954315] [IGT] gem_wait: exiting, ret=0
<14>[  356.061481] [IGT] gem_wait: executing
<4>[  356.076574] Setting dangerous option reset - tainting kernel
<14>[  356.080235] [IGT] gem_wait: starting subtest basic-await-all
<7>[  356.089750] [drm:vgem_gem_dumb_create [vgem]] Created object of size 1
<4>[  357.100402] Setting dangerous option reset - tainting kernel
<14>[  357.104270] [IGT] gem_wait: exiting, ret=0
<14>[  357.192036] [IGT] gem_workarounds: executing
<14>[  357.222144] [IGT] gem_workarounds: starting subtest basic-read
<14>[  357.251734] [IGT] gem_workarounds: exiting, ret=99
<14>[  357.438211] [IGT] kms_addfb_basic: executing
<7>[  357.469388] [drm:drm_mode_addfb2] [FB:99]
<14>[  357.469882] [IGT] kms_addfb_basic: starting subtest addfb25-bad-modifier
<7>[  357.470207] [drm:intel_framebuffer_init [i915]] Unsupported fb modifier 0xffffffffffffffff!
<7>[  357.470308] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  357.477888] [drm:drm_mode_addfb2] [FB:99]
<14>[  357.478057] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  357.591342] [IGT] kms_addfb_basic: executing
<7>[  357.604276] [drm:drm_mode_addfb2] [FB:102]
<14>[  357.604430] [IGT] kms_addfb_basic: starting subtest addfb25-framebuffer-vs-set-tiling
<7>[  357.604457] [drm:drm_mode_addfb2] [FB:102]
<7>[  357.608416] [drm:drm_mode_addfb2] [FB:102]
<14>[  357.608471] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  357.702470] [IGT] kms_addfb_basic: executing
<7>[  357.728335] [drm:drm_mode_addfb2] [FB:99]
<14>[  357.728730] [IGT] kms_addfb_basic: starting subtest addfb25-modifier-no-flag
<7>[  357.728807] [drm:drm_internal_framebuffer_create] bad fb modifier 72057594037927937 for plane 0
<7>[  357.735725] [drm:drm_mode_addfb2] [FB:99]
<14>[  357.735838] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  357.820154] [IGT] kms_addfb_basic: executing
<7>[  357.842160] [drm:drm_mode_addfb2] [FB:102]
<14>[  357.842490] [IGT] kms_addfb_basic: starting subtest addfb25-X-tiled
<7>[  357.842553] [drm:drm_mode_addfb2] [FB:102]
<7>[  357.850301] [drm:drm_mode_addfb2] [FB:102]
<14>[  357.850433] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  357.951562] [IGT] kms_addfb_basic: executing
<7>[  357.990115] [drm:drm_mode_addfb2] [FB:99]
<14>[  357.990429] [IGT] kms_addfb_basic: starting subtest addfb25-X-tiled-mismatch
<7>[  357.990570] [drm:intel_framebuffer_init [i915]] tiling_mode doesn't match fb modifier
<7>[  357.990606] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  357.998317] [drm:drm_mode_addfb2] [FB:99]
<14>[  357.998446] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.093804] [IGT] kms_addfb_basic: executing
<7>[  358.107026] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.107171] [IGT] kms_addfb_basic: starting subtest addfb25-Yf-tiled
<7>[  358.107196] [drm:drm_mode_addfb2] [FB:102]
<7>[  358.110317] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.110370] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.203555] [IGT] kms_addfb_basic: executing
<7>[  358.229984] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.230349] [IGT] kms_addfb_basic: starting subtest addfb25-Y-tiled
<7>[  358.230409] [drm:drm_mode_addfb2] [FB:99]
<7>[  358.238045] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.238172] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.323710] [IGT] kms_addfb_basic: executing
<7>[  358.352701] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.352864] [IGT] kms_addfb_basic: starting subtest addfb25-Y-tiled-small
<7>[  358.352927] [drm:intel_framebuffer_init [i915]] fb too big for bo (need 4194304 bytes, have 4190208 bytes)
<7>[  358.352943] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  358.356096] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.356148] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.458789] [IGT] kms_addfb_basic: executing
<7>[  358.478848] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.478917] [IGT] kms_addfb_basic: starting subtest bad-pitch-0
<7>[  358.478940] [drm:drm_internal_framebuffer_create] bad pitch 0 for plane 0
<7>[  358.482388] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.482464] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.585727] [IGT] kms_addfb_basic: executing
<7>[  358.609640] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.609707] [IGT] kms_addfb_basic: starting subtest bad-pitch-1024
<7>[  358.609730] [drm:drm_internal_framebuffer_create] bad pitch 1024 for plane 0
<7>[  358.613439] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.613504] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.712255] [IGT] kms_addfb_basic: executing
<7>[  358.736750] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.736895] [IGT] kms_addfb_basic: starting subtest bad-pitch-128
<7>[  358.736943] [drm:drm_internal_framebuffer_create] bad pitch 128 for plane 0
<7>[  358.744848] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.744977] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.851889] [IGT] kms_addfb_basic: executing
<7>[  358.880717] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.880814] [IGT] kms_addfb_basic: starting subtest bad-pitch-256
<7>[  358.880846] [drm:drm_internal_framebuffer_create] bad pitch 256 for plane 0
<7>[  358.886763] [drm:drm_mode_addfb2] [FB:102]
<14>[  358.886859] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  358.971394] [IGT] kms_addfb_basic: executing
<7>[  358.989555] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.989623] [IGT] kms_addfb_basic: starting subtest bad-pitch-32
<7>[  358.989646] [drm:drm_internal_framebuffer_create] bad pitch 32 for plane 0
<7>[  358.993167] [drm:drm_mode_addfb2] [FB:99]
<14>[  358.993308] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.071542] [IGT] kms_addfb_basic: executing
<7>[  359.096380] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.096478] [IGT] kms_addfb_basic: starting subtest bad-pitch-63
<7>[  359.096503] [drm:drm_internal_framebuffer_create] bad pitch 63 for plane 0
<7>[  359.100238] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.100302] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.178289] [IGT] kms_addfb_basic: executing
<7>[  359.191387] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.191448] [IGT] kms_addfb_basic: starting subtest bad-pitch-65536
<7>[  359.191501] [drm:intel_framebuffer_init [i915]] linear pitch (65536) must be at most 32768
<7>[  359.191514] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  359.194782] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.194833] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.286268] [IGT] kms_addfb_basic: executing
<7>[  359.313316] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.313401] [IGT] kms_addfb_basic: starting subtest bad-pitch-999
<7>[  359.313428] [drm:drm_internal_framebuffer_create] bad pitch 999 for plane 0
<7>[  359.317444] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.317512] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.408386] [IGT] kms_addfb_basic: executing
<7>[  359.428420] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.428566] [IGT] kms_addfb_basic: starting subtest basic
<7>[  359.428620] [drm:drm_mode_addfb2] [FB:99]
<7>[  359.436454] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.436585] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.533463] [IGT] kms_addfb_basic: executing
<7>[  359.550192] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.553418] [IGT] kms_addfb_basic: starting subtest basic-X-tiled
<7>[  359.553446] [drm:drm_mode_addfb2] [FB:102]
<7>[  359.553499] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.553554] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.641749] [IGT] kms_addfb_basic: executing
<7>[  359.665303] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.673223] [IGT] kms_addfb_basic: starting subtest basic-Y-tiled
<7>[  359.673367] [drm:intel_framebuffer_init [i915]] No Y tiling for legacy addfb
<7>[  359.673402] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  359.673529] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.673643] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.769352] [IGT] kms_addfb_basic: executing
<7>[  359.784167] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.784258] [IGT] kms_addfb_basic: starting subtest bo-too-small
<7>[  359.784315] [drm:intel_framebuffer_init [i915]] fb too big for bo (need 4198400 bytes, have 4190208 bytes)
<7>[  359.784329] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  359.787531] [drm:drm_mode_addfb2] [FB:102]
<14>[  359.787581] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  359.875925] [IGT] kms_addfb_basic: executing
<7>[  359.902129] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.902346] [IGT] kms_addfb_basic: starting subtest bo-too-small-due-to-tiling
<7>[  359.902522] [drm:intel_framebuffer_init [i915]] fb too big for bo (need 4194304 bytes, have 4190208 bytes)
<7>[  359.902562] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  359.910269] [drm:drm_mode_addfb2] [FB:99]
<14>[  359.910395] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.007283] [IGT] kms_addfb_basic: executing
<7>[  360.028067] [drm:drm_mode_addfb2] [FB:102]
<14>[  360.028152] [IGT] kms_addfb_basic: starting subtest clobberred-modifier
<7>[  360.028215] [drm:drm_mode_addfb2] [FB:102]
<7>[  360.036261] [drm:drm_mode_addfb2] [FB:102]
<14>[  360.036389] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.118501] [IGT] kms_addfb_basic: executing
<7>[  360.145064] [drm:drm_mode_addfb2] [FB:99]
<14>[  360.152397] [IGT] kms_addfb_basic: starting subtest framebuffer-vs-set-tiling
<7>[  360.152470] [drm:drm_mode_addfb2] [FB:99]
<7>[  360.152804] [drm:drm_mode_addfb2] [FB:99]
<14>[  360.152960] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.261054] [IGT] kms_addfb_basic: executing
<7>[  360.276468] [drm:drm_mode_addfb2] [FB:102]
<7>[  360.284318] [drm:drm_mode_addfb2] [FB:102]
<14>[  360.284433] [IGT] kms_addfb_basic: starting subtest invalid-get-prop
<14>[  360.284700] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.377924] [IGT] kms_addfb_basic: executing
<7>[  360.406888] [drm:drm_mode_addfb2] [FB:99]
<7>[  360.414675] [drm:drm_mode_addfb2] [FB:99]
<14>[  360.414761] [IGT] kms_addfb_basic: starting subtest invalid-get-prop-any
<14>[  360.414982] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.494320] [IGT] kms_addfb_basic: executing
<7>[  360.509800] [drm:drm_mode_addfb2] [FB:102]
<7>[  360.512981] [drm:drm_mode_addfb2] [FB:102]
<14>[  360.513016] [IGT] kms_addfb_basic: starting subtest invalid-set-prop
<14>[  360.513093] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.604523] [IGT] kms_addfb_basic: executing
<7>[  360.617598] [drm:drm_mode_addfb2] [FB:99]
<7>[  360.620784] [drm:drm_mode_addfb2] [FB:99]
<14>[  360.620820] [IGT] kms_addfb_basic: starting subtest invalid-set-prop-any
<14>[  360.620891] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.703364] [IGT] kms_addfb_basic: executing
<7>[  360.723938] [drm:drm_mode_addfb2] [FB:102]
<14>[  360.724076] [IGT] kms_addfb_basic: starting subtest no-handle
<7>[  360.724122] [drm:drm_internal_framebuffer_create] no buffer object handle for plane 0
<7>[  360.732041] [drm:drm_mode_addfb2] [FB:102]
<14>[  360.732170] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.828312] [IGT] kms_addfb_basic: executing
<7>[  360.866651] [drm:drm_mode_addfb2] [FB:99]
<14>[  360.866865] [IGT] kms_addfb_basic: starting subtest size-max
<7>[  360.866921] [drm:drm_mode_addfb2] [FB:99]
<7>[  360.866950] [drm:drm_mode_addfb2] [FB:99]
<7>[  360.866977] [drm:drm_mode_addfb2] [FB:99]
<7>[  360.875014] [drm:drm_mode_addfb2] [FB:99]
<14>[  360.875179] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  360.973894] [IGT] kms_addfb_basic: executing
<7>[  361.000432] [drm:drm_mode_addfb2] [FB:102]
<14>[  361.000541] [IGT] kms_addfb_basic: starting subtest small-bo
<7>[  361.000567] [drm:drm_mode_addfb2] [FB:102]
<7>[  361.004386] [drm:drm_mode_addfb2] [FB:102]
<14>[  361.004452] [IGT] kms_addfb_basic: exiting, ret=0
<14>[  361.073633] [IGT] kms_addfb_basic: executing
<7>[  361.096452] [drm:drm_mode_addfb2] [FB:99]
<14>[  361.100887] [IGT] kms_addfb_basic: starting subtest tile-pitch-mismatch
<7>[  361.100971] [drm:intel_framebuffer_init [i915]] pitch (2048) must match tiling stride (4096)
<7>[  361.100993] [drm:drm_internal_framebuffer_create] could not create framebuffer
<7>[  361.101065] [drm:drm_mode_addfb2] [FB:99]
<14>[  361.101155] [IGT] kms_addfb_basic: exiting, ret=0
<4>[  361.102119] ------------[ cut here ]------------
<2>[  361.102145] kernel BUG at drivers/gpu/drm/i915/intel_lrc.c:749!
<4>[  361.102163] invalid opcode: 0000 [#1] PREEMPT SMP
<4>[  361.102176] Modules linked in: vgem snd_hda_codec_realtek snd_hda_codec_generic i915 snd_hda_intel x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul snd_hda_codec snd_hwdep snd_hda_core e1000e asix crc32_pclmul snd_pcm ghash_clmulni_intel usbnet mii ptp pps_core prime_numbers i2c_hid
<4>[  361.102273] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G     U          4.14.0-rc2-CI-CI_DRM_3150+ #1
<4>[  361.102293] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X095.A01.1707101424 07/10/2017
<4>[  361.102324] task: ffff880267058040 task.stack: ffffc90000100000
<4>[  361.102385] RIP: 0010:intel_lrc_irq_handler+0x1cb/0x710 [i915]
<4>[  361.102396] RSP: 0018:ffff880271183ea0 EFLAGS: 00010297
<4>[  361.102407] RAX: 0000000000000009 RBX: ffff8802524a8008 RCX: 0000000000000002
<4>[  361.102419] RDX: 0000000000000008 RSI: 0000000000000001 RDI: 00000000ffffffff
<4>[  361.102431] RBP: ffff880271183f00 R08: 0000000000000002 R09: 0000000000000001
<4>[  361.102443] R10: 00000000ffffffff R11: 0000000000000000 R12: 0000000000000004
<4>[  361.102455] R13: 0000000000000018 R14: 0000000000000004 R15: ffff880250968040
<4>[  361.102468] FS:  0000000000000000(0000) GS:ffff880271180000(0000) knlGS:0000000000000000
<4>[  361.102482] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[  361.102492] CR2: 00007f06b513fff8 CR3: 000000025a4b3001 CR4: 00000000006606e0
<4>[  361.102504] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
<4>[  361.102516] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
<4>[  361.102528] PKRU: 55555554
<4>[  361.102534] Call Trace:
<4>[  361.102540]  <IRQ>
<4>[  361.102551]  tasklet_hi_action+0x98/0x120
<4>[  361.102563]  __do_softirq+0xc3/0x4e2
<4>[  361.102574]  irq_exit+0xb5/0xd0
<4>[  361.102582]  do_IRQ+0x71/0x130
<4>[  361.102591]  common_interrupt+0x9a/0x9a
<4>[  361.102599]  </IRQ>
<4>[  361.102606] RIP: 0010:cpuidle_enter_state+0x136/0x370
<4>[  361.102615] RSP: 0018:ffffc90000103e80 EFLAGS: 00000206 ORIG_RAX: ffffffffffffff5d
<4>[  361.102630] RAX: 0000000000000000 RBX: 0000000000002ba9 RCX: 0000000000000000
<4>[  361.102642] RDX: 00000054135c7409 RSI: ffffffff81cb44fe RDI: ffffffff8175ebe2
<4>[  361.102654] RBP: ffffc90000103eb8 R08: 0000000000000055 R09: 0000000000000018
<4>[  361.102666] R10: 000000000000001e R11: 0000000000000046 R12: 0000000000000001
<4>[  361.102679] R13: 0000000000000001 R14: ffff8802650706a8 R15: 00000054135c4860
<4>[  361.102695]  ? cpuidle_enter_state+0x132/0x370
<4>[  361.102706]  cpuidle_enter+0x17/0x20
<4>[  361.102715]  call_cpuidle+0x23/0x40
<4>[  361.102724]  do_idle+0x192/0x1e0
<4>[  361.102734]  cpu_startup_entry+0x1d/0x20
<4>[  361.102743]  start_secondary+0x11c/0x140
<4>[  361.102753]  secondary_startup_64+0xa5/0xa5
<4>[  361.102764] Code: 89 4d c0 e8 c8 6e 74 e1 4c 8b 4d c0 4c 03 4d d0 49 c7 01 00 00 00 00 49 c7 41 08 00 00 00 00 48 8b 83 68 03 00 00 e9 60 ff ff ff <0f> 0b 0f 0b 4c 89 cf e8 e9 ab 48 e1 eb b0 44 3b a3 a4 03 00 00 
<1>[  361.102905] RIP: intel_lrc_irq_handler+0x1cb/0x710 [i915] RSP: ffff880271183ea0
<4>[  361.102927] ---[ end trace 1a3a5d03773e5e95 ]---
Comment 2 Jani Saarinen 2017-10-23 11:03:34 UTC
Dropping priority based on history data:
http://benchsrv.fi.intel.com/cibuglog/?action_failures_history=318
Comment 3 Marta Löfstedt 2017-11-07 08:51:22 UTC

*** This bug has been marked as a duplicate of bug 103525 ***
Comment 4 Daniel Vetter 2017-11-07 10:39:09 UTC
Hm, why is this marked as a dupe of #103525? This here is about cnl (probably another case of DMC breaking shit), the other one is about hsw ... Undupe?
Comment 5 Marta Löfstedt 2017-11-07 10:42:14 UTC
(In reply to Daniel Vetter from comment #4)
> Hm, why is this marked as a dupe of #103525? This here is about cnl
> (probably another case of DMC breaking shit), the other one is about hsw ...
> Undupe?

because I duplicated on the wrong bug should have been:103533

*** This bug has been marked as a duplicate of bug 103533 ***
Comment 6 Chris Wilson 2017-11-07 10:44:09 UTC
(In reply to Marta Löfstedt from comment #5)
> (In reply to Daniel Vetter from comment #4)
> > Hm, why is this marked as a dupe of #103525? This here is about cnl
> > (probably another case of DMC breaking shit), the other one is about hsw ...
> > Undupe?
> 
> because I duplicated on the wrong bug should have been:103533
> 
> *** This bug has been marked as a duplicate of bug 103533 ***

This is not the cnl failure, this is going to sleep too early.
Comment 7 Chris Wilson 2017-11-07 10:45:29 UTC
Unless I have my line no completely messed up.

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.