Processing configuration file
=============================
Reading CM Server options file '/usr/share/dtv.kz/wimaxd.conf'
Option Values In Effect
=======================
BandwidthMHz 10.000
ScanMinFrequencyMHz 0.000
ScanMaxFrequencyMHz 0.000
ScanStepFrequencyMHz 0.000
CenterFrequencyMHz 2663.000
NetworkSearchTimeoutSec 10
LPSearchInShutDownEnabled No
NetworkEntryTimeoutSec 10
NEToHighestCINRBaseStation Yes
AuthEnabled Yes
EAPMethod 4
UserIdentity '001E73807357@aksoran.kz'
UserPassword ''
TTLSAnonymousIdentity ''
ValidateServerCert Yes
CACertPath '/usr/share/dtv.kz'
CACertFileName '/usr/share/dtv.kz/ca.pem'
TLSDeviceCertFileName '/usr/share/dtv.kz/dtv_certificate.pem'
TLSDeviceSubCA1CertFileName ''
TLSDeviceSubCA2CertFileName ''
TLSDevicePrivateKeyFileName '/usr/share/dtv.kz/privatkey.pem'
TLSDevicePrivateKeyPassword ''
PrivateKeyPasswordFormat 'Ascii'
AuthenticationTimeoutSec 10
InvertMSKByteOrder No
AlwaysIncludeTLSLength No
EAPFragmentMaxLength 1398
EAPPollingLoopIntervalMs 50
FirmwareRSAPrivateKeyEncrypt No
FirmwarePrivateKeyBits 2048
InnerNAIChange Yes
BeceemEngineFileName '/usr/src/USB_350/Source/CSCM/bin_pc_linux/bin/libengine_beceem.so'
AuthEthernetToRADIUS No
RADIUSIPAddress '10.128.47.40'
RADIUSPort 1812
RADIUSSecret 'whatever'
AutoReConnectEnabled Yes
AutoReDisconnectEnabled No
SkipNetSearch No
AutoReConnectIntervalSec 20
AutoReDisconnectIntervalSec 20
LinkStatusRequestPeriodSec 2
IPRefreshCommand 'udhcpc --now --quit -i veth0 &'
NetEntryIPRefreshEnabled No
TerminateDHCPClient No
FirmwareFileName '/lib/firmware/macxvi350.bin'
ConfigFileName '/lib/firmware/macxvi.cfg'
CSCMDebugLogLevel 4
CSCMDebugLogFileName '/tmp/CM_Server_Debug.log'
CSCMDebugLogFileMaxSizeMB 1
AuthLogLevel 5
AuthLogFileName '/tmp/CM_Auth.log'
EnableAuthSysLogPrints No
AuthLogFileMaxSizeMB 1
EngineLoggingEnabled Yes
EngineLogFileName '/tmp/CM_Engine.log'
EngineLogFileMaxSizeMB 2
RADIUSClientLogLevel 0
Message queue initialized.
Process messages thread started successfully.
Changed state to: Library initialized
Timer Authentication thread has started.
Timer Check Timeouts thread has started.
Process Messages thread has started.
Timer Periodic Action thread has started.
Changed state to: Waiting for WiMAX adapter ...
Trying to open device.
Device opened successfully.
Registering callback function - Success.
Changed state to: WiMAX adapter initialized
***** Sending subscriber station information request
Sent: 07 00 01 00
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:25.250) ===========
u32State = WiMAX adapter initialized
SS info response received (Type = 7 - Subtype = 1 - Length = 184)
INFO: No socket in BeceemAPI_Unlock()
Client socket FFFFFFFF unlock Beceem API: Was not locked (this is not an error)
Found valid library version: 6.0.37
=============== Received Message End (type=7 sub-type=1) ===============
Changed state to: Waiting for WiMAX adapter ...
***** Sending idle mode status request (2012/01/10 17:30:25.445)
Sent: 13 00 02 00
***** Message sent successfully
***** Sending shutdown status request (2012/01/10 17:30:25.446)
Sent: 1E 00 05 00
=============== Received Message Start (2012/01/10 17:30:25.446) ===========
u32State = Waiting for WiMAX adapter ...
Idle mode response received (Type = 19 - Subtype = 2 - Length =
Idle mode response length = 8
Changed state to: Waiting for WiMAX adapter ...
Not in idle mode.
=============== Received Message End (type=19 sub-type=2) ===============
=============== Received Message Start (2012/01/10 17:30:25.446) ===========
u32State = Waiting for WiMAX adapter ...
Shutdown response received (Type = 30 - Subtype = 5 - Length =
SUBTYPE_SHUTDOWN_MODE_STATUS_RESP return value = 00000001
Changed state to: Waiting for WiMAX adapter ...
=============== Received Message End (type=30 sub-type=5) ===============
***** Message sent successfully
***** Sending half-mini card status request (2012/01/10 17:30:25.446)
Sent: 24 00 01 00
***** Message sent successfully
***** Sending link status request (2012/01/10 17:30:25.446)
Sent: 02 00 03 00
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:25.446) ===========
u32State = Waiting for WiMAX adapter ...
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = WAIT FOR PHY SYNC CMD
Changed state to: Waiting for PHY sync start
=============== Received Message End (type=2 sub-type=2) ===============
=============== Received Message Start (2012/01/10 17:30:25.470) ===========
u32State = Waiting for PHY sync start
Half-mini card response received (Type = 36 - Subtype = 3 - Length = 4)
Changed state to: Half-mini Card Device is not shut down
=============== Received Message End (type=36 sub-type=3) ===============
***** Sending link status request (2012/01/10 17:30:27.448)
Sent: 02 00 03 00
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:27.448) ===========
u32State = Half-mini Card Device is not shut down
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = WAIT FOR PHY SYNC CMD
Changed state to: Waiting for PHY sync start
=============== Received Message End (type=2 sub-type=2) ===============
***** Sending PHY sync down request
Sent: 03 00 01 00
***** Message sent successfully
Changed state to: Sync down request sent
***** Sending link status request (2012/01/10 17:30:27.548)
Sent: 02 00 03 00
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:27.548) ===========
u32State = Sync down request sent
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = WAIT FOR PHY SYNC CMD
Changed state to: Waiting for PHY sync start
Search CF: 2663000
***** Sending network search request (2012/01/10 17:30:27.549)
Sent: 01 00 01 00 00 00 00 00 02 00 00 00 01 00 00 00 10 27 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 01 00 00 00 58 A2 28 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
***** Message sent successfully
=============== Received Message End (type=2 sub-type=2) ===============
=============== Received Message Start (2012/01/10 17:30:27.571) ===========
u32State = Waiting for PHY sync start
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = HOST INITIATED SYNC DOWN
Changed state to: Connection error
=============== Received Message End (type=2 sub-type=2) ===============
=============== Received Message Start (2012/01/10 17:30:27.571) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Device status indication: Device is scanning
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:28.373) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Device status indication: Device is ready
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:28.373) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: Waiting for Sync
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:28.374) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Link status indication: Link Status Normal
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:28.378) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Device status indication: Device is ready
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:28.378) ===========
u32State = Connection error
Network search response received (Type = 1 - Subtype = 1 - Length = 48)
1 base stations found.
Base Station 1
Preamble Index ID: 0x004B
Relative Signal Strength: 0xFFFFFFB5
CINR 0x00000011
Bandwidth 0x00002710
Center frequency 0x0028A258
Base Station ID 6A:21:01:4F:00:00:01:01
-- Network Search status: Network search complete
Changed state to: Network Search completed
Changed state to: Waiting for PHY sync start
=============== Received Message End (type=1 sub-type=1) ===============
INFO: No socket in BeceemAPI_Unlock()
Client socket FFFFFFFF unlock Beceem API: Was not locked (this is not an error)
***** Sending SetWiMAXOptions request with option = 0x10 payload = 0x00000000
Sent: 1D 00 01 00 10 00 00 00 00
***** Message sent successfully
Changed state to: PHY sync in progress
***** Sending PHY sync up request for Preamble ID = 0x4B - Freq = 2663000 - BW = 10000
Sent: 02 00 01 00 58 A2 28 00 10 27 00 00 4B 00 00 00 01 01 00 00 4F 01 21 6A
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:28.467) ===========
u32State = PHY sync in progress
Set WiMAX options response received (Type = 29 - Subtype = 1 - Length = 9)
Set WiMAX Options successful for option 0x10.
=============== Received Message End (type=29 sub-type=1) ===============
=============== Received Message Start (2012/01/10 17:30:28.867) ===========
u32State = PHY sync in progress
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: Phy Sync Achieved
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:28.868) ===========
u32State = PHY sync in progress
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Link status indication: Link Status Normal
=============== Received Message End (type=2 sub-type=5) ===============
***** Sending link status request (2012/01/10 17:30:29.554)
Sent: 02 00 03 00
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:29.555) ===========
u32State = PHY sync in progress
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = WAIT FOR PHY SYNC CMD
Changed state to: Waiting for PHY sync start
=============== Received Message End (type=2 sub-type=2) ===============
=============== Received Message Start (2012/01/10 17:30:29.838) ===========
u32State = Waiting for PHY sync start
Network entry response received (Type = 2 - Subtype = 1 - Length = 68)
Sync Status Response Received
Preamble Index ID: 0x004B
Relative Signal Strength: 0xFFFFFFB5
CINR 0x00000011
Bandwidth 0x00002710
Center frequency 0x0028A258
Base Station ID 6A:21:01:4F:00:00:00:01
Changed state to: Waiting for network entry command
***** Sending network entry request (2012/01/10 17:30:29.838)
Sent: 02 00 02 00 00 00 00 00
***** Message sent successfully
Sync Status Sync up
=============== Received Message End (type=2 sub-type=1) ===============
=============== Received Message Start (2012/01/10 17:30:29.878) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Device status indication: Connection in progress
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:29.878) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: Ranging In Progress
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:29.878) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Link status indication: Link Status Normal
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:29.938) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: SBC In Progress
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:29.938) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Link status indication: Link Status Normal
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.028) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: Device Authentication In Progress
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.028) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Link status indication: Link Status Normal
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.028) ===========
u32State = Waiting for network entry command
Authentication response received (Type = 4 - Subtype = 6 - Length = 11)
Received Auth EAP Transfer Indication - length = 5
EAP msg to supplicant:
0000: 01 39 00 05 01
Starting EAP supplicant thread.
EAP Supplicant is running.
Forwarding EAP message to EAP supplicant.
=============== Received Message End (type=4 sub-type=6) ===============
=============== Received Message Start (2012/01/10 17:30:30.079) ===========
u32State = Waiting for network entry commandMessage from EAP supplicant to Base Station - length = 28
***** Sending EAP transfer request
Sent: 04 00 07 00 1C 00 02 39 00 1C 01 30 30 31 45 37 33 38 30 37 33 35 37 40 61 6B 73 6F 72 61 6E 2E 6B 7A
***** Message sent successfully
=============== Received Message End ===============
=============== Received Message Start (2012/01/10 17:30:30.173) ===========
u32State = Waiting for network entry command
Authentication response received (Type = 4 - Subtype = 6 - Length = 12)
Received Auth EAP Transfer Indication - length = 6
EAP msg to supplicant:
0000: 01 3A 00 06 0D 20
Forwarding EAP message to EAP supplicant.
=============== Received Message End (type=4 sub-type=6) ===============
=============== Received Message Start (2012/01/10 17:30:30.175) ===========
u32State = Waiting for network entry commandMessage from EAP supplicant to Base Station - length = 6
***** Sending EAP transfer request
Sent: 04 00 07 00 06 00 02 3A 00 06 03 00
***** Message sent successfully
=============== Received Message End ===============
=============== Received Message Start (2012/01/10 17:30:30.273) ===========
u32State = Waiting for network entry command
Authentication response received (Type = 4 - Subtype = 6 - Length = 10)
Received Auth EAP Transfer Indication - length = 4
EAP msg to supplicant:
0000: 04 3A 00 04
Forwarding EAP message to EAP supplicant.
=============== Received Message End (type=4 sub-type=6) ===============
=============== Received Message Start (2012/01/10 17:30:30.283) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Device status indication: Device is ready
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.283) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: Waiting for Sync
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.283) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Link status indication: Link Status Normal
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.295) ===========
u32State = Waiting for network entry command
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = WAIT FOR PHY SYNC CMD
Changed state to: Waiting for PHY sync start
=============== Received Message End (type=2 sub-type=2) ===============
***** Sending EAP complete request (EAP status = 1)
Sent: 04 00 08 00 01 02 00 FD FF
***** Message sent successfully
***** Sending PHY sync down request
Sent: 03 00 01 00
***** Message sent successfully
Changed state to: Sync down request sent
--------------------- EAP Authentication ------------------
Authentication failed (key generation)
-----------------------------------------------------------
***** Sending SetWiMAXOptions request with option = 0x10 payload = 0x00000000
Sent: 1D 00 01 00 10 00 00 00 00
***** Message sent successfully
=============== Received Message Start (2012/01/10 17:30:30.570) ===========
u32State = Sync down request sent
Network entry response received (Type = 2 - Subtype = 2 - Length = 52)
Network Entry Status Received
Link status = HOST INITIATED SYNC DOWN
Changed state to: Connection error
=============== Received Message End (type=2 sub-type=2) ===============
=============== Received Message Start (2012/01/10 17:30:30.570) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Device status indication: Device is ready
=============== Received Message End (type=2 sub-type=5) ===============
=============== Received Message Start (2012/01/10 17:30:30.570) ===========
u32State = Connection error
Network entry response received (Type = 2 - Subtype = 5 - Length = 12)
Connection status indication: Waiting for Sync
=============== Received Message End (type=2 sub-type=5) ===============