2016-10-19 17:03:17 [76885] [INFO] Starting gunicorn 18.0
2016-10-19 17:03:17 [76885] [DEBUG] Arbiter booted
2016-10-19 17:03:17 [76885] [INFO] Listening at: http://0.0.0.0:5000 (76885)
2016-10-19 17:03:17 [76885] [INFO] Using worker: sync
2016-10-19 17:03:17 [76889] [INFO] Booting worker with pid: 76889
/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/SQLAlchemy-1.1.0-py2.7-macosx-10.11-intel.egg/sqlalchemy/orm/mapper.py:1034: SAWarning: Reassigning polymorphic association for identity 'war_of_the_ghosts_source' from <Mapper at 0x1118fe890; WarOfTheGhostsSource> to <Mapper at 0x1118feb10; WarOfTheGhostsSource>: Check for duplicate use of 'war_of_the_ghosts_source' as value for polymorphic_identity.
2016-10-19 17:03:18,279 /Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/psiturk_dallinger-3.1.3-py2.7.egg/psiturk/psiturk_js/psiturk.js
2016-10-19 17:03:19 [76889] [DEBUG] Closing connection. 
2016-10-19 17:03:19,155 Closing connection. 
2016-10-19 17:03:21 [76889] [DEBUG] POST /launch
2016-10-19 17:03:21,377 POST /launch
>>>> ----- Launching experiment...
2016-10-19 17:03:21,586 Starting new HTTPS connection (1): api.psiturk.org
2016-10-19 17:03:21,862 "GET /api/ad HTTP/1.1" 200 1050729
2016-10-19 17:03:22,415 Using access key provided by client.
2016-10-19 17:03:22,416 Using secret key provided by client.
2016-10-19 17:03:22,416 Method: GET
2016-10-19 17:03:22,416 Path: /
2016-10-19 17:03:22,416 Data: 
2016-10-19 17:03:22,416 Headers: {}
2016-10-19 17:03:22,416 Host: rds.amazonaws.com
2016-10-19 17:03:22,416 Port: 443
2016-10-19 17:03:22,416 Params: {'Action': 'DescribeDBInstances', 'Version': '2013-05-15'}
2016-10-19 17:03:22,417 establishing HTTPS connection: host=rds.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-19 17:03:22,417 Token: None
2016-10-19 17:03:22,417 CanonicalRequest:
GET
/
Action=DescribeDBInstances&Version=2013-05-15
host:rds.amazonaws.com
x-amz-date:20161019T210322Z

host;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2016-10-19 17:03:22,417 StringToSign:
AWS4-HMAC-SHA256
20161019T210322Z
20161019/us-east-1/rds/aws4_request
c7fae25af40d065645ec487c2394c0507529bb972e60b6c30d9d882b3e17d539
2016-10-19 17:03:22,417 Signature:
df3aa674b089de570aab61be99a6c2d47b3f4e737c8feb67203c6d2451ed9fc2
2016-10-19 17:03:22,445 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-19 17:03:22,516 validating server certificate: hostname=rds.amazonaws.com, certificate hosts=['rds.us-east-1.amazonaws.com', 'us-east-1.rds.amazonaws.com', 'rds.amazonaws.com']
2016-10-19 17:03:22,598 <DescribeDBInstancesResponse xmlns="http://rds.amazonaws.com/doc/2013-05-15/">
  <DescribeDBInstancesResult>
    <DBInstances/>
  </DescribeDBInstancesResult>
  <ResponseMetadata>
    <RequestId>782ed5b3-963f-11e6-a5ec-995d573baa4b</RequestId>
  </ResponseMetadata>
</DescribeDBInstancesResponse>

2016-10-19 17:03:22,599 Using access key provided by client.
2016-10-19 17:03:22,600 Using secret key provided by client.
2016-10-19 17:03:22,600 Method: POST
2016-10-19 17:03:22,600 Path: /
2016-10-19 17:03:22,600 Data: 
2016-10-19 17:03:22,600 Headers: {}
2016-10-19 17:03:22,601 Host: mechanicalturk.amazonaws.com
2016-10-19 17:03:22,601 Port: 443
2016-10-19 17:03:22,601 Params: {'Operation': 'GetAccountBalance', 'Version': '2012-03-25'}
2016-10-19 17:03:22,601 establishing HTTPS connection: host=mechanicalturk.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-19 17:03:22,601 Token: None
2016-10-19 17:03:22,601 using _calc_signature_1
2016-10-19 17:03:22,601 query_string: AWSAccessKeyId=AKIAJ7GUQU3FPLXVOGGQ&Operation=GetAccountBalance&SignatureVersion=1&Timestamp=2016-10-19T21%3A03%3A22Z&Version=2012-03-25 Signature: 7i4pEQN/sgXQIp9vBJziGgvmJCI=
2016-10-19 17:03:22,632 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-19 17:03:22,717 validating server certificate: hostname=mechanicalturk.amazonaws.com, certificate hosts=['mechanicalturk.amazonaws.com']
Reject recruitment reopening: experiment has started.
launch request successful.
2016-10-19 17:03:22,960 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-19 17:03:22,960 Closing Dallinger DB session at flask request end
127.0.0.1 - - [19/Oct/2016:17:03:22] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-19 17:03:22,961 127.0.0.1 - - [19/Oct/2016:17:03:22] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-19 17:03:26 [76889] [DEBUG] Closing connection. 
2016-10-19 17:03:26,021 Closing connection. 
2016-10-19 17:03:26 [76889] [DEBUG] Closing connection. 
2016-10-19 17:03:26,430 Closing connection. 
2016-10-19 17:03:26 [76889] [DEBUG] Closing connection. 
2016-10-19 17:03:26,431 Closing connection. 
2016-10-19 17:03:26 [76889] [DEBUG] GET /ppid
2016-10-19 17:03:26,432 GET /ppid
127.0.0.1 - - [19/Oct/2016:17:03:26] "GET /ppid HTTP/1.1" 200 5 "-" "Python-urllib/2.7"
2016-10-19 17:03:26,433 127.0.0.1 - - [19/Oct/2016:17:03:26] "GET /ppid HTTP/1.1" 200 5 "-" "Python-urllib/2.7"
2016-10-19 17:03:26 [76889] [DEBUG] Closing connection. 
2016-10-19 17:03:26,470 Closing connection. 
2016-10-19 17:03:26 [76889] [INFO] Parent changed, shutting down: <Worker 76889>
2016-10-19 17:03:26,470 Parent changed, shutting down: <Worker 76889>
2016-10-19 17:03:26 [76889] [INFO] Worker exiting (pid: 76889)
2016-10-19 17:03:26,471 Worker exiting (pid: 76889)
2016-10-20 21:40:59 [44008] [INFO] Starting gunicorn 18.0
2016-10-20 21:40:59 [44008] [DEBUG] Arbiter booted
2016-10-20 21:40:59 [44008] [INFO] Listening at: http://0.0.0.0:5000 (44008)
2016-10-20 21:40:59 [44008] [INFO] Using worker: sync
2016-10-20 21:40:59 [44012] [INFO] Booting worker with pid: 44012
/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/SQLAlchemy-1.1.0-py2.7-macosx-10.11-intel.egg/sqlalchemy/orm/mapper.py:1034: SAWarning: Reassigning polymorphic association for identity 'war_of_the_ghosts_source' from <Mapper at 0x109499810; WarOfTheGhostsSource> to <Mapper at 0x109499a90; WarOfTheGhostsSource>: Check for duplicate use of 'war_of_the_ghosts_source' as value for polymorphic_identity.
2016-10-20 21:41:00,069 /Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/psiturk_dallinger-3.1.3-py2.7.egg/psiturk/psiturk_js/psiturk.js
2016-10-20 21:41:00 [44012] [DEBUG] Closing connection. 
2016-10-20 21:41:00,675 Closing connection. 
2016-10-20 21:41:02 [44012] [DEBUG] POST /launch
2016-10-20 21:41:02,939 POST /launch
>>>> ----- Launching experiment...
2016-10-20 21:41:03,205 Starting new HTTPS connection (1): api.psiturk.org
2016-10-20 21:41:03,462 "GET /api/ad HTTP/1.1" 200 1050729
2016-10-20 21:41:04,068 Using access key provided by client.
2016-10-20 21:41:04,069 Using secret key provided by client.
2016-10-20 21:41:04,069 Method: GET
2016-10-20 21:41:04,069 Path: /
2016-10-20 21:41:04,069 Data: 
2016-10-20 21:41:04,069 Headers: {}
2016-10-20 21:41:04,069 Host: rds.amazonaws.com
2016-10-20 21:41:04,069 Port: 443
2016-10-20 21:41:04,069 Params: {'Action': 'DescribeDBInstances', 'Version': '2013-05-15'}
2016-10-20 21:41:04,070 establishing HTTPS connection: host=rds.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-20 21:41:04,070 Token: None
2016-10-20 21:41:04,070 CanonicalRequest:
GET
/
Action=DescribeDBInstances&Version=2013-05-15
host:rds.amazonaws.com
x-amz-date:20161021T014104Z

host;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2016-10-20 21:41:04,070 StringToSign:
AWS4-HMAC-SHA256
20161021T014104Z
20161021/us-east-1/rds/aws4_request
fa8a30e6119e5c1f2850da7bd85b2a8e1307fb2b97ab1e3bbf2733fb1744406c
2016-10-20 21:41:04,070 Signature:
67cfb67f6f9c9fd7315ad007740cc46065fe8f5e483079ff6d9b1c78c31df0cb
2016-10-20 21:41:04,102 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-20 21:41:04,171 validating server certificate: hostname=rds.amazonaws.com, certificate hosts=['rds.us-east-1.amazonaws.com', 'us-east-1.rds.amazonaws.com', 'rds.amazonaws.com']
2016-10-20 21:41:04,230 <DescribeDBInstancesResponse xmlns="http://rds.amazonaws.com/doc/2013-05-15/">
  <DescribeDBInstancesResult>
    <DBInstances/>
  </DescribeDBInstancesResult>
  <ResponseMetadata>
    <RequestId>6db6c448-972f-11e6-b114-a9be4f63f508</RequestId>
  </ResponseMetadata>
</DescribeDBInstancesResponse>

2016-10-20 21:41:04,231 Using access key provided by client.
2016-10-20 21:41:04,232 Using secret key provided by client.
2016-10-20 21:41:04,232 Method: POST
2016-10-20 21:41:04,232 Path: /
2016-10-20 21:41:04,232 Data: 
2016-10-20 21:41:04,232 Headers: {}
2016-10-20 21:41:04,233 Host: mechanicalturk.amazonaws.com
2016-10-20 21:41:04,233 Port: 443
2016-10-20 21:41:04,233 Params: {'Operation': 'GetAccountBalance', 'Version': '2012-03-25'}
2016-10-20 21:41:04,233 establishing HTTPS connection: host=mechanicalturk.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-20 21:41:04,233 Token: None
2016-10-20 21:41:04,233 using _calc_signature_1
2016-10-20 21:41:04,234 query_string: AWSAccessKeyId=AKIAJ7GUQU3FPLXVOGGQ&Operation=GetAccountBalance&SignatureVersion=1&Timestamp=2016-10-21T01%3A41%3A04Z&Version=2012-03-25 Signature: +y4xpA+YwRdvH+KFTr78cISJlDo=
2016-10-20 21:41:04,267 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-20 21:41:04,344 validating server certificate: hostname=mechanicalturk.amazonaws.com, certificate hosts=['mechanicalturk.amazonaws.com']
Reject recruitment reopening: experiment has started.
launch request successful.
2016-10-20 21:41:04,607 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:41:04,607 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:41:04] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-20 21:41:04,607 127.0.0.1 - - [20/Oct/2016:21:41:04] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-20 21:43:02 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:02,654 Closing connection. 
2016-10-20 21:43:02 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:02,697 Closing connection. 
2016-10-20 21:43:19 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:19,979 Closing connection. 
2016-10-20 21:43:20 [44012] [DEBUG] GET /ad
2016-10-20 21:43:20,628 GET /ad
127.0.0.1 - - [20/Oct/2016:21:43:20] "GET /ad?assignmentId=debugWHB0AJ&hitId=debugXV9O4J&workerId=debug58URUF&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:43:20,670 127.0.0.1 - - [20/Oct/2016:21:43:20] "GET /ad?assignmentId=debugWHB0AJ&hitId=debugXV9O4J&workerId=debug58URUF&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:43:20 [44012] [DEBUG] GET /static/css/bootstrap.min.css
2016-10-20 21:43:20,679 GET /static/css/bootstrap.min.css
127.0.0.1 - - [20/Oct/2016:21:43:20] "GET /static/css/bootstrap.min.css HTTP/1.1" 200 99961 "http://0.0.0.0:5000/ad?assignmentId=debugWHB0AJ&hitId=debugXV9O4J&workerId=debug58URUF&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:43:20,693 127.0.0.1 - - [20/Oct/2016:21:43:20] "GET /static/css/bootstrap.min.css HTTP/1.1" 200 99961 "http://0.0.0.0:5000/ad?assignmentId=debugWHB0AJ&hitId=debugXV9O4J&workerId=debug58URUF&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:43:20 [44012] [DEBUG] GET /static/images/logo.png
2016-10-20 21:43:20,694 GET /static/images/logo.png
127.0.0.1 - - [20/Oct/2016:21:43:20] "GET /static/images/logo.png HTTP/1.1" 200 1005 "http://0.0.0.0:5000/ad?assignmentId=debugWHB0AJ&hitId=debugXV9O4J&workerId=debug58URUF&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:43:20,696 127.0.0.1 - - [20/Oct/2016:21:43:20] "GET /static/images/logo.png HTTP/1.1" 200 1005 "http://0.0.0.0:5000/ad?assignmentId=debugWHB0AJ&hitId=debugXV9O4J&workerId=debug58URUF&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:43:31 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:31,368 Closing connection. 
2016-10-20 21:43:31 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:31,370 Closing connection. 
2016-10-20 21:43:31 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:31,371 Closing connection. 
2016-10-20 21:43:31 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:31,371 Closing connection. 
2016-10-20 21:43:31 [44012] [DEBUG] Closing connection. 
2016-10-20 21:43:31,372 Closing connection. 
2016-10-20 21:44:12 [44012] [INFO] Worker exiting (pid: 44012)
2016-10-20 21:44:12 [44008] [INFO] Handling signal: int
2016-10-20 21:44:12,603 Worker exiting (pid: 44012)
2016-10-20 21:44:12 [44008] [INFO] Shutting down: Master
2016-10-20 21:44:24 [44305] [INFO] Starting gunicorn 18.0
2016-10-20 21:44:24 [44305] [DEBUG] Arbiter booted
2016-10-20 21:44:24 [44305] [INFO] Listening at: http://0.0.0.0:5000 (44305)
2016-10-20 21:44:24 [44305] [INFO] Using worker: sync
2016-10-20 21:44:24 [44309] [INFO] Booting worker with pid: 44309
/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/SQLAlchemy-1.1.0-py2.7-macosx-10.11-intel.egg/sqlalchemy/orm/mapper.py:1034: SAWarning: Reassigning polymorphic association for identity 'war_of_the_ghosts_source' from <Mapper at 0x1048d4810; WarOfTheGhostsSource> to <Mapper at 0x1048d4a90; WarOfTheGhostsSource>: Check for duplicate use of 'war_of_the_ghosts_source' as value for polymorphic_identity.
2016-10-20 21:44:25,187 /Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/psiturk_dallinger-3.1.3-py2.7.egg/psiturk/psiturk_js/psiturk.js
2016-10-20 21:44:25 [44309] [DEBUG] Closing connection. 
2016-10-20 21:44:25,874 Closing connection. 
2016-10-20 21:44:28 [44309] [DEBUG] POST /launch
2016-10-20 21:44:28,129 POST /launch
>>>> ----- Launching experiment...
2016-10-20 21:44:28,358 Starting new HTTPS connection (1): api.psiturk.org
2016-10-20 21:44:28,607 "GET /api/ad HTTP/1.1" 200 1050729
2016-10-20 21:44:30,381 Using access key provided by client.
2016-10-20 21:44:30,381 Using secret key provided by client.
2016-10-20 21:44:30,381 Method: GET
2016-10-20 21:44:30,381 Path: /
2016-10-20 21:44:30,382 Data: 
2016-10-20 21:44:30,382 Headers: {}
2016-10-20 21:44:30,382 Host: rds.amazonaws.com
2016-10-20 21:44:30,382 Port: 443
2016-10-20 21:44:30,382 Params: {'Action': 'DescribeDBInstances', 'Version': '2013-05-15'}
2016-10-20 21:44:30,382 establishing HTTPS connection: host=rds.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-20 21:44:30,382 Token: None
2016-10-20 21:44:30,383 CanonicalRequest:
GET
/
Action=DescribeDBInstances&Version=2013-05-15
host:rds.amazonaws.com
x-amz-date:20161021T014430Z

host;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2016-10-20 21:44:30,383 StringToSign:
AWS4-HMAC-SHA256
20161021T014430Z
20161021/us-east-1/rds/aws4_request
35895f969ee746574a6927945c3a1d45c1e73125735bc1789841c1c35052d09e
2016-10-20 21:44:30,383 Signature:
a12df136efdda2bbf0219278e71757aee8489dd05d05a192b6b4be0c1d8e6b74
2016-10-20 21:44:30,420 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-20 21:44:30,499 validating server certificate: hostname=rds.amazonaws.com, certificate hosts=['rds.us-east-1.amazonaws.com', 'us-east-1.rds.amazonaws.com', 'rds.amazonaws.com']
2016-10-20 21:44:30,548 <DescribeDBInstancesResponse xmlns="http://rds.amazonaws.com/doc/2013-05-15/">
  <DescribeDBInstancesResult>
    <DBInstances/>
  </DescribeDBInstancesResult>
  <ResponseMetadata>
    <RequestId>e8b0b330-972f-11e6-b847-3fe505f33d52</RequestId>
  </ResponseMetadata>
</DescribeDBInstancesResponse>

2016-10-20 21:44:30,549 Using access key provided by client.
2016-10-20 21:44:30,550 Using secret key provided by client.
2016-10-20 21:44:30,550 Method: POST
2016-10-20 21:44:30,550 Path: /
2016-10-20 21:44:30,550 Data: 
2016-10-20 21:44:30,551 Headers: {}
2016-10-20 21:44:30,551 Host: mechanicalturk.amazonaws.com
2016-10-20 21:44:30,551 Port: 443
2016-10-20 21:44:30,551 Params: {'Operation': 'GetAccountBalance', 'Version': '2012-03-25'}
2016-10-20 21:44:30,551 establishing HTTPS connection: host=mechanicalturk.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-20 21:44:30,551 Token: None
2016-10-20 21:44:30,551 using _calc_signature_1
2016-10-20 21:44:30,551 query_string: AWSAccessKeyId=AKIAJ7GUQU3FPLXVOGGQ&Operation=GetAccountBalance&SignatureVersion=1&Timestamp=2016-10-21T01%3A44%3A30Z&Version=2012-03-25 Signature: 15AzuXI3soHVAkWq4rnaVakhSgQ=
2016-10-20 21:44:30,596 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-20 21:44:30,836 validating server certificate: hostname=mechanicalturk.amazonaws.com, certificate hosts=['mechanicalturk.amazonaws.com']
Reject recruitment reopening: experiment has started.
launch request successful.
2016-10-20 21:44:31,068 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:44:31,068 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:44:31] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-20 21:44:31,069 127.0.0.1 - - [20/Oct/2016:21:44:31] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-20 21:44:32 [44309] [DEBUG] Closing connection. 
2016-10-20 21:44:32,690 Closing connection. 
2016-10-20 21:44:32 [44309] [DEBUG] Closing connection. 
2016-10-20 21:44:32,747 Closing connection. 
2016-10-20 21:45:07 [44309] [DEBUG] GET /ad
2016-10-20 21:45:07,227 GET /ad
127.0.0.1 - - [20/Oct/2016:21:45:07] "GET /ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:07,257 127.0.0.1 - - [20/Oct/2016:21:45:07] "GET /ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:07 [44309] [DEBUG] GET /static/css/bootstrap.min.css
2016-10-20 21:45:07,270 GET /static/css/bootstrap.min.css
127.0.0.1 - - [20/Oct/2016:21:45:07] "GET /static/css/bootstrap.min.css HTTP/1.1" 200 99961 "http://0.0.0.0:5000/ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:07,282 127.0.0.1 - - [20/Oct/2016:21:45:07] "GET /static/css/bootstrap.min.css HTTP/1.1" 200 99961 "http://0.0.0.0:5000/ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:07 [44309] [DEBUG] GET /static/images/logo.png
2016-10-20 21:45:07,282 GET /static/images/logo.png
127.0.0.1 - - [20/Oct/2016:21:45:07] "GET /static/images/logo.png HTTP/1.1" 200 1005 "http://0.0.0.0:5000/ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:07,285 127.0.0.1 - - [20/Oct/2016:21:45:07] "GET /static/images/logo.png HTTP/1.1" 200 1005 "http://0.0.0.0:5000/ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] GET /consent
2016-10-20 21:45:10,069 GET /consent
2016-10-20 21:45:10,071 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:10,071 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,072 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugO8W1JG&hitId=debugJESTKE&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] GET /static/scripts/jquery-min.js
2016-10-20 21:45:10,164 GET /static/scripts/jquery-min.js
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/jquery-min.js HTTP/1.1" 200 93107 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,166 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/jquery-min.js HTTP/1.1" 200 93107 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] GET /static/scripts/reqwest.min.js
2016-10-20 21:45:10,166 GET /static/scripts/reqwest.min.js
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/reqwest.min.js HTTP/1.1" 200 9342 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,168 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/reqwest.min.js HTTP/1.1" 200 9342 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] Closing connection. 
2016-10-20 21:45:10,169 Closing connection. 
2016-10-20 21:45:10 [44309] [DEBUG] GET /static/scripts/store+json2.min.js
2016-10-20 21:45:10,170 GET /static/scripts/store+json2.min.js
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/store+json2.min.js HTTP/1.1" 200 6783 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,172 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/store+json2.min.js HTTP/1.1" 200 6783 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] GET /static/scripts/dallinger.js
2016-10-20 21:45:10,173 GET /static/scripts/dallinger.js
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/dallinger.js HTTP/1.1" 200 4373 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,176 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/dallinger.js HTTP/1.1" 200 4373 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] GET /static/css/dallinger.css
2016-10-20 21:45:10,176 GET /static/css/dallinger.css
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/css/dallinger.css HTTP/1.1" 200 366 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,179 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/css/dallinger.css HTTP/1.1" 200 366 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10 [44309] [DEBUG] GET /static/scripts/experiment.js
2016-10-20 21:45:10,180 GET /static/scripts/experiment.js
127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/experiment.js HTTP/1.1" 200 3101 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:10,182 127.0.0.1 - - [20/Oct/2016:21:45:10] "GET /static/scripts/experiment.js HTTP/1.1" 200 3101 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:11 [44309] [DEBUG] GET /instructions
2016-10-20 21:45:11,198 GET /instructions
2016-10-20 21:45:11,200 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:11,200 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:11] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:11,200 127.0.0.1 - - [20/Oct/2016:21:45:11] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debugJESTKE&assignment_id=debugO8W1JG&worker_id=debugWMRMQ8&workerId=debugWMRMQ8&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:11 [44309] [DEBUG] POST /participant/debugWMRMQ8/debugJESTKE/debugO8W1JG/debug
2016-10-20 21:45:11,358 POST /participant/debugWMRMQ8/debugJESTKE/debugO8W1JG/debug
participant post request successful.
2016-10-20 21:45:11,376 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:11,376 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:11] "POST /participant/debugWMRMQ8/debugJESTKE/debugO8W1JG/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:11,377 127.0.0.1 - - [20/Oct/2016:21:45:11] "POST /participant/debugWMRMQ8/debugJESTKE/debugO8W1JG/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12 [44309] [DEBUG] GET /exp
2016-10-20 21:45:12,137 GET /exp
2016-10-20 21:45:12,139 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:12,139 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:12] "GET /exp?participant_id=1 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12,140 127.0.0.1 - - [20/Oct/2016:21:45:12] "GET /exp?participant_id=1 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12 [44309] [DEBUG] GET /static/scripts/markdown.min.js
2016-10-20 21:45:12,151 GET /static/scripts/markdown.min.js
127.0.0.1 - - [20/Oct/2016:21:45:12] "GET /static/scripts/markdown.min.js HTTP/1.1" 200 16798 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12,153 127.0.0.1 - - [20/Oct/2016:21:45:12] "GET /static/scripts/markdown.min.js HTTP/1.1" 200 16798 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12 [44309] [DEBUG] POST /node/1
2016-10-20 21:45:12,360 POST /node/1
>>>> 1 1 networks out of 1 available
>>>> 1 No practice networks available.Assigning participant to experiment network 1
/node POST request successful.
2016-10-20 21:45:12,470 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:12,470 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:12] "POST /node/1 HTTP/1.1" 200 276 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12,471 127.0.0.1 - - [20/Oct/2016:21:45:12] "POST /node/1 HTTP/1.1" 200 276 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12 [44309] [DEBUG] GET /node/2/received_infos
2016-10-20 21:45:12,523 GET /node/2/received_infos
received infos request successful.
2016-10-20 21:45:12,539 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:12,539 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:12] "GET /node/2/received_infos HTTP/1.1" 200 2334 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:12,539 127.0.0.1 - - [20/Oct/2016:21:45:12] "GET /node/2/received_infos HTTP/1.1" 200 2334 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:14 [44309] [DEBUG] POST /info/2
2016-10-20 21:45:14,960 POST /info/2
info post request successful.
2016-10-20 21:45:14,983 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:14,983 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:14] "POST /info/2 HTTP/1.1" 200 293 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:14,983 127.0.0.1 - - [20/Oct/2016:21:45:14] "POST /info/2 HTTP/1.1" 200 293 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:14 [44309] [DEBUG] POST /node/1
2016-10-20 21:45:14,988 POST /node/1
>>>> 1 No networks available, returning None
2016-10-20 21:45:14,995 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:14,995 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:14] "POST /node/1 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:14,996 127.0.0.1 - - [20/Oct/2016:21:45:14] "POST /node/1 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:15 [44309] [DEBUG] GET /questionnaire
2016-10-20 21:45:15,015 GET /questionnaire
2016-10-20 21:45:15,017 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:15,017 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:15] "GET /questionnaire?participant_id=1 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:15,018 127.0.0.1 - - [20/Oct/2016:21:45:15] "GET /questionnaire?participant_id=1 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] POST /question/1
2016-10-20 21:45:16,232 POST /question/1
question post request successful.
2016-10-20 21:45:16,248 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,248 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,248 127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] POST /question/1
2016-10-20 21:45:16,249 POST /question/1
question post request successful.
2016-10-20 21:45:16,259 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,259 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,260 127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] POST /question/1
2016-10-20 21:45:16,261 POST /question/1
question post request successful.
2016-10-20 21:45:16,270 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,270 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,270 127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] POST /question/1
2016-10-20 21:45:16,271 POST /question/1
question post request successful.
2016-10-20 21:45:16,281 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,281 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,282 127.0.0.1 - - [20/Oct/2016:21:45:16] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] GET /participant/1
2016-10-20 21:45:16,283 GET /participant/1
participant get request successful.
2016-10-20 21:45:16,287 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,287 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,288 127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] GET /participant/1
2016-10-20 21:45:16,290 GET /participant/1
participant get request successful.
2016-10-20 21:45:16,294 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,294 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,295 127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] GET /ad_address/debug/debugJESTKE
2016-10-20 21:45:16,295 GET /ad_address/debug/debugJESTKE
ad_address request successful.
2016-10-20 21:45:16,296 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,296 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /ad_address/debug/debugJESTKE HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,297 127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /ad_address/debug/debugJESTKE HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] GET /ad_address/debug/debugJESTKE
2016-10-20 21:45:16,302 GET /ad_address/debug/debugJESTKE
ad_address request successful.
2016-10-20 21:45:16,303 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-20 21:45:16,303 Closing Dallinger DB session at flask request end
127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /ad_address/debug/debugJESTKE HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,303 127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /ad_address/debug/debugJESTKE HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16 [44309] [DEBUG] GET /complete
2016-10-20 21:45:16,342 GET /complete
127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /complete?uniqueId=debugWMRMQ8:debugO8W1JG HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:16,344 127.0.0.1 - - [20/Oct/2016:21:45:16] "GET /complete?uniqueId=debugWMRMQ8:debugO8W1JG HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
2016-10-20 21:45:20 [44309] [DEBUG] Closing connection. 
2016-10-20 21:45:20,801 Closing connection. 
2016-10-20 21:45:21 [44309] [DEBUG] Closing connection. 
2016-10-20 21:45:21,278 Closing connection. 
2016-10-20 21:45:21 [44309] [DEBUG] Closing connection. 
2016-10-20 21:45:21,278 Closing connection. 
2016-10-20 21:45:21 [44309] [DEBUG] GET /ppid
2016-10-20 21:45:21,279 GET /ppid
127.0.0.1 - - [20/Oct/2016:21:45:21] "GET /ppid HTTP/1.1" 200 5 "-" "Python-urllib/2.7"
2016-10-20 21:45:21,280 127.0.0.1 - - [20/Oct/2016:21:45:21] "GET /ppid HTTP/1.1" 200 5 "-" "Python-urllib/2.7"
2016-10-20 21:45:21 [44309] [DEBUG] Closing connection. 
2016-10-20 21:45:21,324 Closing connection. 
2016-10-20 21:45:21 [44309] [INFO] Parent changed, shutting down: <Worker 44309>
2016-10-20 21:45:21,325 Parent changed, shutting down: <Worker 44309>
2016-10-20 21:45:21 [44309] [INFO] Worker exiting (pid: 44309)
2016-10-20 21:45:21,325 Worker exiting (pid: 44309)
2016-10-28 16:38:56 [66966] [INFO] Starting gunicorn 18.0
2016-10-28 16:38:56 [66966] [DEBUG] Arbiter booted
2016-10-28 16:38:56 [66966] [INFO] Listening at: http://0.0.0.0:5000 (66966)
2016-10-28 16:38:56 [66966] [INFO] Using worker: sync
2016-10-28 16:38:56 [66969] [INFO] Booting worker with pid: 66969
/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/SQLAlchemy-1.1.0-py2.7-macosx-10.11-intel.egg/sqlalchemy/orm/mapper.py:1034: SAWarning: Reassigning polymorphic association for identity 'war_of_the_ghosts_source' from <Mapper at 0x108a239d0; WarOfTheGhostsSource> to <Mapper at 0x108a23c50; WarOfTheGhostsSource>: Check for duplicate use of 'war_of_the_ghosts_source' as value for polymorphic_identity.
2016-10-28 16:38:56,689 /Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/psiturk_dallinger-3.1.3-py2.7.egg/psiturk/psiturk_js/psiturk.js
2016-10-28 16:38:57 [66969] [DEBUG] Closing connection. 
2016-10-28 16:38:57,744 Closing connection. 
2016-10-28 16:39:00 [66969] [DEBUG] POST /launch
2016-10-28 16:39:00,024 POST /launch
>>>> ----- Launching experiment...
2016-10-28 16:39:00,223 Starting new HTTPS connection (1): api.psiturk.org
2016-10-28 16:39:00,457 "GET /api/ad HTTP/1.1" 200 1068006
2016-10-28 16:39:00,987 Using access key provided by client.
2016-10-28 16:39:00,987 Using secret key provided by client.
2016-10-28 16:39:00,988 Method: GET
2016-10-28 16:39:00,988 Path: /
2016-10-28 16:39:00,988 Data: 
2016-10-28 16:39:00,988 Headers: {}
2016-10-28 16:39:00,988 Host: rds.amazonaws.com
2016-10-28 16:39:00,988 Port: 443
2016-10-28 16:39:00,988 Params: {'Action': 'DescribeDBInstances', 'Version': '2013-05-15'}
2016-10-28 16:39:00,988 establishing HTTPS connection: host=rds.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-28 16:39:00,989 Token: None
2016-10-28 16:39:00,989 CanonicalRequest:
GET
/
Action=DescribeDBInstances&Version=2013-05-15
host:rds.amazonaws.com
x-amz-date:20161028T203900Z

host;x-amz-date
e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855
2016-10-28 16:39:00,989 StringToSign:
AWS4-HMAC-SHA256
20161028T203900Z
20161028/us-east-1/rds/aws4_request
42175667514491701aaefd8963d30e6c0812479c004c75a10f72b1cfdef8ae96
2016-10-28 16:39:00,989 Signature:
ed43f2399bee5f4a652a57ce4307fc1e12933ecefa5e6227527239d723eab361
2016-10-28 16:39:01,017 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-28 16:39:01,086 validating server certificate: hostname=rds.amazonaws.com, certificate hosts=['rds.us-east-1.amazonaws.com', 'us-east-1.rds.amazonaws.com', 'rds.amazonaws.com']
2016-10-28 16:39:01,137 <DescribeDBInstancesResponse xmlns="http://rds.amazonaws.com/doc/2013-05-15/">
  <DescribeDBInstancesResult>
    <DBInstances/>
  </DescribeDBInstancesResult>
  <ResponseMetadata>
    <RequestId>8ed544e8-9d4e-11e6-ae7e-3f9d55d0c52f</RequestId>
  </ResponseMetadata>
</DescribeDBInstancesResponse>

2016-10-28 16:39:01,138 Using access key provided by client.
2016-10-28 16:39:01,138 Using secret key provided by client.
2016-10-28 16:39:01,139 Method: POST
2016-10-28 16:39:01,139 Path: /
2016-10-28 16:39:01,139 Data: 
2016-10-28 16:39:01,139 Headers: {}
2016-10-28 16:39:01,139 Host: mechanicalturk.amazonaws.com
2016-10-28 16:39:01,139 Port: 443
2016-10-28 16:39:01,139 Params: {'Operation': 'GetAccountBalance', 'Version': '2012-03-25'}
2016-10-28 16:39:01,139 establishing HTTPS connection: host=mechanicalturk.amazonaws.com, kwargs={'port': 443, 'timeout': 70}
2016-10-28 16:39:01,139 Token: None
2016-10-28 16:39:01,140 using _calc_signature_1
2016-10-28 16:39:01,140 query_string: AWSAccessKeyId=AKIAJ7GUQU3FPLXVOGGQ&Operation=GetAccountBalance&SignatureVersion=1&Timestamp=2016-10-28T20%3A39%3A01Z&Version=2012-03-25 Signature: +lx7uN3OVIR+K6p0nSsdILPZSoY=
2016-10-28 16:39:01,168 wrapping ssl socket; CA certificate file=/Users/jordansuchow/.virtualenvs/dallinger/lib/python2.7/site-packages/boto/cacerts/cacerts.txt
2016-10-28 16:39:01,241 validating server certificate: hostname=mechanicalturk.amazonaws.com, certificate hosts=['mechanicalturk.amazonaws.com']
Reject recruitment reopening: experiment has started.
launch request successful.
2016-10-28 16:39:01,506 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:01,506 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:01] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-28 16:39:01,507 127.0.0.1 - - [28/Oct/2016:16:39:01] "POST /launch HTTP/1.1" 200 21 "-" "curl/7.43.0"
2016-10-28 16:39:03 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:03,618 Closing connection. 
2016-10-28 16:39:03 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:03,656 Closing connection. 
2016-10-28 16:39:04 [66969] [DEBUG] GET /ad
2016-10-28 16:39:04,343 GET /ad
127.0.0.1 - - [28/Oct/2016:16:39:04] "GET /ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:04,388 127.0.0.1 - - [28/Oct/2016:16:39:04] "GET /ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:04 [66969] [DEBUG] GET /static/css/bootstrap.min.css
2016-10-28 16:39:04,403 GET /static/css/bootstrap.min.css
127.0.0.1 - - [28/Oct/2016:16:39:04] "GET /static/css/bootstrap.min.css HTTP/1.1" 200 99961 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:04,420 127.0.0.1 - - [28/Oct/2016:16:39:04] "GET /static/css/bootstrap.min.css HTTP/1.1" 200 99961 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:04 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:04,421 Closing connection. 
2016-10-28 16:39:04 [66969] [DEBUG] GET /static/images/logo.png
2016-10-28 16:39:04,422 GET /static/images/logo.png
127.0.0.1 - - [28/Oct/2016:16:39:04] "GET /static/images/logo.png HTTP/1.1" 200 1005 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:04,448 127.0.0.1 - - [28/Oct/2016:16:39:04] "GET /static/images/logo.png HTTP/1.1" 200 1005 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /favicon.ico
2016-10-28 16:39:05,199 GET /favicon.ico
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /favicon.ico HTTP/1.1" 200 318 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,201 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /favicon.ico HTTP/1.1" 200 318 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /consent
2016-10-28 16:39:05,586 GET /consent
2016-10-28 16:39:05,589 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:05,589 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,589 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debug7ZFLMM&hitId=debugOEP3EK&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /static/scripts/jquery-min.js
2016-10-28 16:39:05,656 GET /static/scripts/jquery-min.js
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/jquery-min.js HTTP/1.1" 200 93107 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,659 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/jquery-min.js HTTP/1.1" 200 93107 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /static/scripts/reqwest.min.js
2016-10-28 16:39:05,659 GET /static/scripts/reqwest.min.js
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/reqwest.min.js HTTP/1.1" 200 9342 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,662 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/reqwest.min.js HTTP/1.1" 200 9342 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /static/scripts/store+json2.min.js
2016-10-28 16:39:05,663 GET /static/scripts/store+json2.min.js
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/store+json2.min.js HTTP/1.1" 200 6783 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,665 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/store+json2.min.js HTTP/1.1" 200 6783 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /static/css/dallinger.css
2016-10-28 16:39:05,666 GET /static/css/dallinger.css
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/css/dallinger.css HTTP/1.1" 200 366 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,668 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/css/dallinger.css HTTP/1.1" 200 366 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /static/scripts/dallinger.js
2016-10-28 16:39:05,669 GET /static/scripts/dallinger.js
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/dallinger.js HTTP/1.1" 200 4228 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,670 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/dallinger.js HTTP/1.1" 200 4228 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05 [66969] [DEBUG] GET /static/scripts/experiment.js
2016-10-28 16:39:05,671 GET /static/scripts/experiment.js
127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/experiment.js HTTP/1.1" 200 3101 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:05,673 127.0.0.1 - - [28/Oct/2016:16:39:05] "GET /static/scripts/experiment.js HTTP/1.1" 200 3101 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:06 [66969] [DEBUG] GET /instructions
2016-10-28 16:39:06,586 GET /instructions
2016-10-28 16:39:06,588 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:06,588 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:06] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:06,588 127.0.0.1 - - [28/Oct/2016:16:39:06] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debugOEP3EK&assignment_id=debug7ZFLMM&worker_id=debugPLBM6E&workerId=debugPLBM6E&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:06 [66969] [DEBUG] POST /participant/debugPLBM6E/debugOEP3EK/debug7ZFLMM/debug
2016-10-28 16:39:06,743 POST /participant/debugPLBM6E/debugOEP3EK/debug7ZFLMM/debug
participant post request successful.
2016-10-28 16:39:06,761 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:06,761 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:06] "POST /participant/debugPLBM6E/debugOEP3EK/debug7ZFLMM/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:06,762 127.0.0.1 - - [28/Oct/2016:16:39:06] "POST /participant/debugPLBM6E/debugOEP3EK/debug7ZFLMM/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07 [66969] [DEBUG] GET /exp
2016-10-28 16:39:07,466 GET /exp
2016-10-28 16:39:07,468 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:07,468 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:07] "GET /exp?participant_id=1 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07,468 127.0.0.1 - - [28/Oct/2016:16:39:07] "GET /exp?participant_id=1 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07 [66969] [DEBUG] GET /static/scripts/markdown.min.js
2016-10-28 16:39:07,483 GET /static/scripts/markdown.min.js
127.0.0.1 - - [28/Oct/2016:16:39:07] "GET /static/scripts/markdown.min.js HTTP/1.1" 200 16798 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07,485 127.0.0.1 - - [28/Oct/2016:16:39:07] "GET /static/scripts/markdown.min.js HTTP/1.1" 200 16798 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07 [66969] [DEBUG] POST /node/1
2016-10-28 16:39:07,586 POST /node/1
>>>> 1 1 networks out of 1 available
>>>> 1 No practice networks available.Assigning participant to experiment network 1
/node POST request successful.
2016-10-28 16:39:07,700 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:07,700 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:07] "POST /node/1 HTTP/1.1" 200 276 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07,701 127.0.0.1 - - [28/Oct/2016:16:39:07] "POST /node/1 HTTP/1.1" 200 276 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07 [66969] [DEBUG] GET /node/2/received_infos
2016-10-28 16:39:07,762 GET /node/2/received_infos
received infos request successful.
2016-10-28 16:39:07,778 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:07,778 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:07] "GET /node/2/received_infos HTTP/1.1" 200 2334 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:07,779 127.0.0.1 - - [28/Oct/2016:16:39:07] "GET /node/2/received_infos HTTP/1.1" 200 2334 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:10 [66969] [DEBUG] POST /info/2
2016-10-28 16:39:10,913 POST /info/2
info post request successful.
2016-10-28 16:39:10,932 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:10,932 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:10] "POST /info/2 HTTP/1.1" 200 293 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:10,934 127.0.0.1 - - [28/Oct/2016:16:39:10] "POST /info/2 HTTP/1.1" 200 293 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:10 [66969] [DEBUG] POST /node/1
2016-10-28 16:39:10,939 POST /node/1
>>>> 1 No networks available, returning None
2016-10-28 16:39:10,947 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:10,947 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:10] "POST /node/1 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:10,947 127.0.0.1 - - [28/Oct/2016:16:39:10] "POST /node/1 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:10 [66969] [DEBUG] GET /questionnaire
2016-10-28 16:39:10,963 GET /questionnaire
2016-10-28 16:39:10,965 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:10,965 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:10] "GET /questionnaire?participant_id=1 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:10,966 127.0.0.1 - - [28/Oct/2016:16:39:10] "GET /questionnaire?participant_id=1 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,203 POST /question/1
question post request successful.
2016-10-28 16:39:12,214 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,214 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,214 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,215 POST /question/1
question post request successful.
2016-10-28 16:39:12,227 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,227 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,227 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] GET /participant/1
2016-10-28 16:39:12,228 GET /participant/1
participant get request successful.
2016-10-28 16:39:12,232 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,232 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,232 127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] GET /participant/1
2016-10-28 16:39:12,233 GET /participant/1
participant get request successful.
2016-10-28 16:39:12,237 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,237 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,237 127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /participant/1 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,238 POST /question/1
question post request successful.
2016-10-28 16:39:12,248 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,248 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,248 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,249 POST /question/1
question post request successful.
2016-10-28 16:39:12,258 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,258 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,259 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] GET /ad_address/debug/debugOEP3EK
2016-10-28 16:39:12,260 GET /ad_address/debug/debugOEP3EK
ad_address request successful.
2016-10-28 16:39:12,261 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,261 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /ad_address/debug/debugOEP3EK HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,262 127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /ad_address/debug/debugOEP3EK HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,262 POST /question/1
question post request successful.
2016-10-28 16:39:12,274 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,274 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,275 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] GET /ad_address/debug/debugOEP3EK
2016-10-28 16:39:12,275 GET /ad_address/debug/debugOEP3EK
ad_address request successful.
2016-10-28 16:39:12,277 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,277 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /ad_address/debug/debugOEP3EK HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,277 127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /ad_address/debug/debugOEP3EK HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,278 POST /question/1
question post request successful.
2016-10-28 16:39:12,291 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,291 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,292 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,293 POST /question/1
question post request successful.
2016-10-28 16:39:12,306 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,306 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,307 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,308 POST /question/1
question post request successful.
2016-10-28 16:39:12,317 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,317 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,318 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] GET /complete
2016-10-28 16:39:12,319 GET /complete
127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /complete?uniqueId=debugPLBM6E:debug7ZFLMM HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,321 127.0.0.1 - - [28/Oct/2016:16:39:12] "GET /complete?uniqueId=debugPLBM6E:debug7ZFLMM HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,322 POST /question/1
question post request successful.
2016-10-28 16:39:12,334 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,334 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12,335 127.0.0.1 - - [28/Oct/2016:16:39:12] "POST /question/1 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=1" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:12 [66969] [DEBUG] POST /question/1
2016-10-28 16:39:12,336 POST /question/1
question post request successful.
2016-10-28 16:39:12,348 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:12,348 Closing Dallinger DB session at flask request end
2016-10-28 16:39:12 [66969] [DEBUG] Ignoring EPIPE
2016-10-28 16:39:12,349 Ignoring EPIPE
2016-10-28 16:39:14 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:14,919 Closing connection. 
2016-10-28 16:39:14 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:14,958 Closing connection. 
2016-10-28 16:39:15 [66969] [DEBUG] GET /ad
2016-10-28 16:39:15,476 GET /ad
127.0.0.1 - - [28/Oct/2016:16:39:15] "GET /ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:15,492 127.0.0.1 - - [28/Oct/2016:16:39:15] "GET /ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:15 [66969] [DEBUG] GET /static/css/bootstrap.min.css
2016-10-28 16:39:15,505 GET /static/css/bootstrap.min.css
127.0.0.1 - - [28/Oct/2016:16:39:15] "GET /static/css/bootstrap.min.css HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:15,507 127.0.0.1 - - [28/Oct/2016:16:39:15] "GET /static/css/bootstrap.min.css HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:15 [66969] [DEBUG] GET /static/images/logo.png
2016-10-28 16:39:15,508 GET /static/images/logo.png
127.0.0.1 - - [28/Oct/2016:16:39:15] "GET /static/images/logo.png HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:15,510 127.0.0.1 - - [28/Oct/2016:16:39:15] "GET /static/images/logo.png HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] GET /consent
2016-10-28 16:39:16,696 GET /consent
2016-10-28 16:39:16,697 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:16,697 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,698 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugHKFXBZ&hitId=debug9MEZM3&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] GET /static/scripts/jquery-min.js
2016-10-28 16:39:16,767 GET /static/scripts/jquery-min.js
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/jquery-min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,769 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/jquery-min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] GET /static/scripts/reqwest.min.js
2016-10-28 16:39:16,770 GET /static/scripts/reqwest.min.js
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/reqwest.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,772 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/reqwest.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:16,773 Closing connection. 
2016-10-28 16:39:16 [66969] [DEBUG] GET /static/scripts/store+json2.min.js
2016-10-28 16:39:16,773 GET /static/scripts/store+json2.min.js
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/store+json2.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,775 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/store+json2.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] GET /static/scripts/dallinger.js
2016-10-28 16:39:16,776 GET /static/scripts/dallinger.js
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/dallinger.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,779 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/dallinger.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] GET /static/css/dallinger.css
2016-10-28 16:39:16,780 GET /static/css/dallinger.css
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/css/dallinger.css HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,782 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/css/dallinger.css HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16 [66969] [DEBUG] GET /static/scripts/experiment.js
2016-10-28 16:39:16,782 GET /static/scripts/experiment.js
127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/experiment.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:16,785 127.0.0.1 - - [28/Oct/2016:16:39:16] "GET /static/scripts/experiment.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:17 [66969] [DEBUG] GET /instructions
2016-10-28 16:39:17,578 GET /instructions
2016-10-28 16:39:17,579 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:17,579 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:17] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:17,580 127.0.0.1 - - [28/Oct/2016:16:39:17] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debug9MEZM3&assignment_id=debugHKFXBZ&worker_id=debugJEIR9Q&workerId=debugJEIR9Q&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:17 [66969] [DEBUG] POST /participant/debugJEIR9Q/debug9MEZM3/debugHKFXBZ/debug
2016-10-28 16:39:17,736 POST /participant/debugJEIR9Q/debug9MEZM3/debugHKFXBZ/debug
participant post request successful.
2016-10-28 16:39:17,747 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:17,747 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:17] "POST /participant/debugJEIR9Q/debug9MEZM3/debugHKFXBZ/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:17,748 127.0.0.1 - - [28/Oct/2016:16:39:17] "POST /participant/debugJEIR9Q/debug9MEZM3/debugHKFXBZ/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18 [66969] [DEBUG] GET /exp
2016-10-28 16:39:18,289 GET /exp
2016-10-28 16:39:18,290 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:18,290 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:18] "GET /exp?participant_id=2 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18,290 127.0.0.1 - - [28/Oct/2016:16:39:18] "GET /exp?participant_id=2 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18 [66969] [DEBUG] GET /static/scripts/markdown.min.js
2016-10-28 16:39:18,305 GET /static/scripts/markdown.min.js
127.0.0.1 - - [28/Oct/2016:16:39:18] "GET /static/scripts/markdown.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18,307 127.0.0.1 - - [28/Oct/2016:16:39:18] "GET /static/scripts/markdown.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18 [66969] [DEBUG] POST /node/2
2016-10-28 16:39:18,414 POST /node/2
>>>> 2 1 networks out of 1 available
>>>> 2 No practice networks available.Assigning participant to experiment network 1
/node POST request successful.
2016-10-28 16:39:18,502 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:18,502 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:18] "POST /node/2 HTTP/1.1" 200 276 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18,503 127.0.0.1 - - [28/Oct/2016:16:39:18] "POST /node/2 HTTP/1.1" 200 276 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18 [66969] [DEBUG] GET /node/3/received_infos
2016-10-28 16:39:18,582 GET /node/3/received_infos
received infos request successful.
2016-10-28 16:39:18,593 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:18,593 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:18] "GET /node/3/received_infos HTTP/1.1" 200 296 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:18,594 127.0.0.1 - - [28/Oct/2016:16:39:18] "GET /node/3/received_infos HTTP/1.1" 200 296 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:21 [66969] [DEBUG] POST /info/3
2016-10-28 16:39:21,097 POST /info/3
info post request successful.
2016-10-28 16:39:21,116 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:21,116 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:21] "POST /info/3 HTTP/1.1" 200 293 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:21,117 127.0.0.1 - - [28/Oct/2016:16:39:21] "POST /info/3 HTTP/1.1" 200 293 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:21 [66969] [DEBUG] POST /node/2
2016-10-28 16:39:21,127 POST /node/2
>>>> 2 No networks available, returning None
2016-10-28 16:39:21,134 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:21,134 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:21] "POST /node/2 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:21,135 127.0.0.1 - - [28/Oct/2016:16:39:21] "POST /node/2 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:21 [66969] [DEBUG] GET /questionnaire
2016-10-28 16:39:21,148 GET /questionnaire
2016-10-28 16:39:21,149 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:21,149 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:21] "GET /questionnaire?participant_id=2 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:21,150 127.0.0.1 - - [28/Oct/2016:16:39:21] "GET /questionnaire?participant_id=2 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,773 POST /question/2
question post request successful.
2016-10-28 16:39:22,782 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,782 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,782 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,783 POST /question/2
question post request successful.
2016-10-28 16:39:22,794 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,794 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,795 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] GET /participant/2
2016-10-28 16:39:22,796 GET /participant/2
participant get request successful.
2016-10-28 16:39:22,799 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,799 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /participant/2 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,799 127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /participant/2 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,800 POST /question/2
question post request successful.
2016-10-28 16:39:22,811 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,811 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,812 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,813 POST /question/2
question post request successful.
2016-10-28 16:39:22,824 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,824 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,825 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] GET /participant/2
2016-10-28 16:39:22,826 GET /participant/2
participant get request successful.
2016-10-28 16:39:22,829 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,829 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /participant/2 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,830 127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /participant/2 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] GET /ad_address/debug/debug9MEZM3
2016-10-28 16:39:22,830 GET /ad_address/debug/debug9MEZM3
ad_address request successful.
2016-10-28 16:39:22,831 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,831 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /ad_address/debug/debug9MEZM3 HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,832 127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /ad_address/debug/debug9MEZM3 HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,832 POST /question/2
question post request successful.
2016-10-28 16:39:22,845 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,845 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,845 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,846 POST /question/2
question post request successful.
2016-10-28 16:39:22,856 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,856 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,857 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] GET /ad_address/debug/debug9MEZM3
2016-10-28 16:39:22,858 GET /ad_address/debug/debug9MEZM3
ad_address request successful.
2016-10-28 16:39:22,859 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,859 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /ad_address/debug/debug9MEZM3 HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,859 127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /ad_address/debug/debug9MEZM3 HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] GET /complete
2016-10-28 16:39:22,860 GET /complete
127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /complete?uniqueId=debugJEIR9Q:debugHKFXBZ HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,862 127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /complete?uniqueId=debugJEIR9Q:debugHKFXBZ HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,862 POST /question/2
question post request successful.
2016-10-28 16:39:22,878 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,878 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,878 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,879 POST /question/2
question post request successful.
2016-10-28 16:39:22,891 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,891 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,892 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,892 POST /question/2
question post request successful.
2016-10-28 16:39:22,904 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,904 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,905 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] GET /complete
2016-10-28 16:39:22,906 GET /complete
127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /complete?uniqueId=debugJEIR9Q:debugHKFXBZ HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,908 127.0.0.1 - - [28/Oct/2016:16:39:22] "GET /complete?uniqueId=debugJEIR9Q:debugHKFXBZ HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,908 POST /question/2
question post request successful.
2016-10-28 16:39:22,930 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,930 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,930 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22 [66969] [DEBUG] POST /question/2
2016-10-28 16:39:22,931 POST /question/2
question post request successful.
2016-10-28 16:39:22,951 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:22,951 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:22,952 127.0.0.1 - - [28/Oct/2016:16:39:22] "POST /question/2 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=2" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:37 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:37,704 Closing connection. 
2016-10-28 16:39:37 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:37,743 Closing connection. 
2016-10-28 16:39:38 [66969] [DEBUG] GET /ad
2016-10-28 16:39:38,281 GET /ad
127.0.0.1 - - [28/Oct/2016:16:39:38] "GET /ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:38,296 127.0.0.1 - - [28/Oct/2016:16:39:38] "GET /ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug HTTP/1.1" 200 1847 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:38 [66969] [DEBUG] GET /static/css/bootstrap.min.css
2016-10-28 16:39:38,307 GET /static/css/bootstrap.min.css
127.0.0.1 - - [28/Oct/2016:16:39:38] "GET /static/css/bootstrap.min.css HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:38,309 127.0.0.1 - - [28/Oct/2016:16:39:38] "GET /static/css/bootstrap.min.css HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:38 [66969] [DEBUG] GET /static/images/logo.png
2016-10-28 16:39:38,310 GET /static/images/logo.png
127.0.0.1 - - [28/Oct/2016:16:39:38] "GET /static/images/logo.png HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:38,312 127.0.0.1 - - [28/Oct/2016:16:39:38] "GET /static/images/logo.png HTTP/1.1" 304 - "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] GET /consent
2016-10-28 16:39:39,527 GET /consent
2016-10-28 16:39:39,528 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:39,528 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,528 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] GET /static/scripts/jquery-min.js
2016-10-28 16:39:39,607 GET /static/scripts/jquery-min.js
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/jquery-min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,610 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/jquery-min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] GET /static/scripts/reqwest.min.js
2016-10-28 16:39:39,614 GET /static/scripts/reqwest.min.js
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/reqwest.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,618 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/reqwest.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:39,619 Closing connection. 
2016-10-28 16:39:39 [66969] [DEBUG] GET /static/css/dallinger.css
2016-10-28 16:39:39,620 GET /static/css/dallinger.css
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/css/dallinger.css HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,623 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/css/dallinger.css HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] GET /static/scripts/store+json2.min.js
2016-10-28 16:39:39,624 GET /static/scripts/store+json2.min.js
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/store+json2.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,626 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/store+json2.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] GET /static/scripts/dallinger.js
2016-10-28 16:39:39,626 GET /static/scripts/dallinger.js
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/dallinger.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,629 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/dallinger.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39 [66969] [DEBUG] GET /static/scripts/experiment.js
2016-10-28 16:39:39,629 GET /static/scripts/experiment.js
127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/experiment.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:39,632 127.0.0.1 - - [28/Oct/2016:16:39:39] "GET /static/scripts/experiment.js HTTP/1.1" 304 - "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:42 [66969] [DEBUG] GET /consent
2016-10-28 16:39:42,532 GET /consent
2016-10-28 16:39:42,533 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:42,533 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:42] "GET /consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:42,534 127.0.0.1 - - [28/Oct/2016:16:39:42] "GET /consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug HTTP/1.1" 200 3142 "http://0.0.0.0:5000/ad?assignmentId=debugS0EC4B&hitId=debugGMVENH&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:43 [66969] [DEBUG] GET /instructions
2016-10-28 16:39:43,603 GET /instructions
2016-10-28 16:39:43,604 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:43,604 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:43] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:43,605 127.0.0.1 - - [28/Oct/2016:16:39:43] "GET /instructions HTTP/1.1" 200 1208 "http://0.0.0.0:5000/consent?hit_id=debugGMVENH&assignment_id=debugS0EC4B&worker_id=debug1XBTGG&workerId=debug1XBTGG&mode=debug" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:43 [66969] [DEBUG] POST /participant/debug1XBTGG/debugGMVENH/debugS0EC4B/debug
2016-10-28 16:39:43,731 POST /participant/debug1XBTGG/debugGMVENH/debugS0EC4B/debug
participant post request successful.
2016-10-28 16:39:43,739 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:43,739 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:43] "POST /participant/debug1XBTGG/debugGMVENH/debugS0EC4B/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:43,740 127.0.0.1 - - [28/Oct/2016:16:39:43] "POST /participant/debug1XBTGG/debugGMVENH/debugS0EC4B/debug HTTP/1.1" 200 466 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44 [66969] [DEBUG] GET /exp
2016-10-28 16:39:44,723 GET /exp
2016-10-28 16:39:44,723 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:44,723 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:44] "GET /exp?participant_id=3 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44,724 127.0.0.1 - - [28/Oct/2016:16:39:44] "GET /exp?participant_id=3 HTTP/1.1" 200 1671 "http://0.0.0.0:5000/instructions" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44 [66969] [DEBUG] GET /static/scripts/markdown.min.js
2016-10-28 16:39:44,741 GET /static/scripts/markdown.min.js
127.0.0.1 - - [28/Oct/2016:16:39:44] "GET /static/scripts/markdown.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/exp?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44,743 127.0.0.1 - - [28/Oct/2016:16:39:44] "GET /static/scripts/markdown.min.js HTTP/1.1" 304 - "http://0.0.0.0:5000/exp?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44 [66969] [DEBUG] POST /node/3
2016-10-28 16:39:44,845 POST /node/3
>>>> 3 No networks available, returning None
2016-10-28 16:39:44,855 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:44,855 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:44] "POST /node/3 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44,856 127.0.0.1 - - [28/Oct/2016:16:39:44] "POST /node/3 HTTP/1.1" 403 19 "http://0.0.0.0:5000/exp?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44 [66969] [DEBUG] GET /questionnaire
2016-10-28 16:39:44,964 GET /questionnaire
2016-10-28 16:39:44,965 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:44,965 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:44] "GET /questionnaire?participant_id=3 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:44,966 127.0.0.1 - - [28/Oct/2016:16:39:44] "GET /questionnaire?participant_id=3 HTTP/1.1" 200 3303 "http://0.0.0.0:5000/exp?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,015 POST /question/3
question post request successful.
2016-10-28 16:39:47,024 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,024 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,025 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,025 POST /question/3
question post request successful.
2016-10-28 16:39:47,035 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,035 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,035 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] GET /participant/3
2016-10-28 16:39:47,036 GET /participant/3
participant get request successful.
2016-10-28 16:39:47,040 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,040 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /participant/3 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,040 127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /participant/3 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,041 POST /question/3
question post request successful.
2016-10-28 16:39:47,051 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,051 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,051 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,052 POST /question/3
question post request successful.
2016-10-28 16:39:47,061 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,061 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,061 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] GET /participant/3
2016-10-28 16:39:47,062 GET /participant/3
participant get request successful.
2016-10-28 16:39:47,066 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,066 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /participant/3 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,066 127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /participant/3 HTTP/1.1" 200 466 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] GET /ad_address/debug/debugGMVENH
2016-10-28 16:39:47,067 GET /ad_address/debug/debugGMVENH
ad_address request successful.
2016-10-28 16:39:47,068 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,068 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /ad_address/debug/debugGMVENH HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,068 127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /ad_address/debug/debugGMVENH HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,069 POST /question/3
question post request successful.
2016-10-28 16:39:47,082 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,082 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,083 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,083 POST /question/3
question post request successful.
2016-10-28 16:39:47,093 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,093 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,093 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] GET /ad_address/debug/debugGMVENH
2016-10-28 16:39:47,094 GET /ad_address/debug/debugGMVENH
ad_address request successful.
2016-10-28 16:39:47,095 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,095 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /ad_address/debug/debugGMVENH HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,096 127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /ad_address/debug/debugGMVENH HTTP/1.1" 200 45 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] GET /complete
2016-10-28 16:39:47,097 GET /complete
127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /complete?uniqueId=debug1XBTGG:debugS0EC4B HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,100 127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /complete?uniqueId=debug1XBTGG:debugS0EC4B HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,100 POST /question/3
question post request successful.
2016-10-28 16:39:47,112 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,112 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,112 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,113 POST /question/3
question post request successful.
2016-10-28 16:39:47,127 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,127 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,127 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,128 POST /question/3
question post request successful.
2016-10-28 16:39:47,137 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,137 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,138 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] GET /complete
2016-10-28 16:39:47,139 GET /complete
127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /complete?uniqueId=debug1XBTGG:debugS0EC4B HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,140 127.0.0.1 - - [28/Oct/2016:16:39:47] "GET /complete?uniqueId=debug1XBTGG:debugS0EC4B HTTP/1.1" 200 630 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,141 POST /question/3
question post request successful.
2016-10-28 16:39:47,155 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,155 Closing Dallinger DB session at flask request end
2016-10-28 16:39:47 [66969] [DEBUG] Ignoring EPIPE
2016-10-28 16:39:47,156 Ignoring EPIPE
2016-10-28 16:39:47 [66969] [DEBUG] POST /question/3
2016-10-28 16:39:47,157 POST /question/3
question post request successful.
2016-10-28 16:39:47,172 - dallinger.db - DEBUG - Closing Dallinger DB session at flask request end
2016-10-28 16:39:47,172 Closing Dallinger DB session at flask request end
127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:47,173 127.0.0.1 - - [28/Oct/2016:16:39:47] "POST /question/3 HTTP/1.1" 200 21 "http://0.0.0.0:5000/questionnaire?participant_id=3" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/54.0.2840.71 Safari/537.36"
2016-10-28 16:39:50 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:50,155 Closing connection. 
2016-10-28 16:39:50 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:50,645 Closing connection. 
2016-10-28 16:39:50 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:50,645 Closing connection. 
2016-10-28 16:39:50 [66969] [DEBUG] GET /ppid
2016-10-28 16:39:50,646 GET /ppid
127.0.0.1 - - [28/Oct/2016:16:39:50] "GET /ppid HTTP/1.1" 200 5 "-" "Python-urllib/2.7"
2016-10-28 16:39:50,647 127.0.0.1 - - [28/Oct/2016:16:39:50] "GET /ppid HTTP/1.1" 200 5 "-" "Python-urllib/2.7"
2016-10-28 16:39:50 [66969] [DEBUG] Closing connection. 
2016-10-28 16:39:50,697 Closing connection. 
2016-10-28 16:39:50 [66969] [INFO] Parent changed, shutting down: <Worker 66969>
2016-10-28 16:39:50,697 Parent changed, shutting down: <Worker 66969>
2016-10-28 16:39:50 [66969] [INFO] Worker exiting (pid: 66969)
2016-10-28 16:39:50,698 Worker exiting (pid: 66969)
