builder: mozilla-central_win8_64_test-dromaeojs-e10s
slave: t-w864-ix-031
starttime: 1492133635.21
results: failure (2)
buildid: 20170413172451
builduid: 398d5ab1413f41fa82aac857b42395f4
revision: 198effec6e11460e977f13e9cb83050a21a64d27

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 18:33:55.212707) =========
master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 18:33:55.213290) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 18:33:55.213648) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 18:33:55.504876) =========

========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-13 18:33:55.505448) =========
'bash' '-c' 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=T-W864-IX-031
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld.T-W864-IX-031
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Local
  LOGONSERVER=\\T-W864-IX-031
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg;
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_ARCHITEW6432=AMD64
  PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files (x86)
  PROGRAMFILES(X86)=C:\Program Files (x86)
  PROGRAMW6432=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  USERDOMAIN=T-W864-IX-031
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-031
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-031
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
--18:33:57--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
           => `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,179 (12K) [text/x-python]

    0K .......... .                                          100%   22.47 MB/s

18:33:58 (22.47 MB/s) - `archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=2.940000
========= master_lag: 0.07 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-13 18:33:58.513539) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 20 secs) (at 2017-04-13 18:33:58.514492) =========
'rm' '-rf' 'scripts' 'properties'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts', 'properties']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=T-W864-IX-031
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld.T-W864-IX-031
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Local
  LOGONSERVER=\\T-W864-IX-031
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg;
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_ARCHITEW6432=AMD64
  PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files (x86)
  PROGRAMFILES(X86)=C:\Program Files (x86)
  PROGRAMW6432=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  USERDOMAIN=T-W864-IX-031
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-031
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-031
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
program finished with exit code 0
elapsedTime=20.436000
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 20 secs) (at 2017-04-13 18:34:18.984255) =========

========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-13 18:34:18.984645) =========
'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 198effec6e11460e977f13e9cb83050a21a64d27 --destination scripts --debug'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 198effec6e11460e977f13e9cb83050a21a64d27 --destination scripts --debug']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=T-W864-IX-031
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld.T-W864-IX-031
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Local
  LOGONSERVER=\\T-W864-IX-031
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg;
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_ARCHITEW6432=AMD64
  PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files (x86)
  PROGRAMFILES(X86)=C:\Program Files (x86)
  PROGRAMW6432=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  USERDOMAIN=T-W864-IX-031
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-031
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-031
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
2017-04-13 18:34:20,032 truncating revision to first 12 chars
2017-04-13 18:34:20,032 Setting DEBUG logging.
2017-04-13 18:34:20,032 attempt 1/10
2017-04-13 18:34:20,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/198effec6e11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-04-13 18:34:20,602 unpacking tar archive at: mozilla-central-198effec6e11/testing/mozharness/
2017-04-13 18:34:21,128 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=2.135000
========= master_lag: 0.23 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-13 18:34:21.348872) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 18:34:21.349390) =========
script_repo_revision: 198effec6e11460e977f13e9cb83050a21a64d27
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 18:34:21.350011) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 18:34:21.350488) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 18:34:21.376041) =========

========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 25 mins, 34 secs) (at 2017-04-13 18:34:21.376528) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs-e10s' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox-Non-PGO' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox-Non-PGO'
 in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
 watching logfiles {}
 argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=T-W864-IX-031
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld.T-W864-IX-031
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Local
  LOGONSERVER=\\T-W864-IX-031
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg;
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_ARCHITEW6432=AMD64
  PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files (x86)
  PROGRAMFILES(X86)=C:\Program Files (x86)
  PROGRAMW6432=C:\Program Files
  PROMPT=$P$G
  PROPERTIES_FILE=C:\slave\test/buildprops.json
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  USERDOMAIN=T-W864-IX-031
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-031
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-031
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
18:34:22     INFO - MultiFileLogger online at 20170413 18:34:22 in C:\slave\test
18:34:22     INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO
18:34:22     INFO - Dumping config to C:\slave\test\logs\localconfig.json.
18:34:22     INFO - {'append_to_log': False,
18:34:22     INFO -  'base_work_dir': 'C:\\slave\\test',
18:34:22     INFO -  'blob_upload_branch': 'Firefox-Non-PGO',
18:34:22     INFO -  'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
18:34:22     INFO -  'branch': 'Firefox-Non-PGO',
18:34:22     INFO -  'buildbot_json_path': 'buildprops.json',
18:34:22     INFO -  'config_files': ('talos/windows_config.py',),
18:34:22     INFO -  'default_actions': ('clobber',
18:34:22     INFO -                      'read-buildbot-config',
18:34:22     INFO -                      'download-and-extract',
18:34:22     INFO -                      'populate-webroot',
18:34:22     INFO -                      'create-virtualenv',
18:34:22     INFO -                      'install',
18:34:22     INFO -                      'run-tests'),
18:34:22     INFO -  'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
18:34:22     INFO -  'download_minidump_stackwalk': True,
18:34:22     INFO -  'download_symbols': 'ondemand',
18:34:22     INFO -  'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
18:34:22     INFO -                            'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
18:34:22     INFO -           'hg': 'c:/mozilla-build/hg/hg',
18:34:22     INFO -           'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
18:34:22     INFO -                          'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
18:34:22     INFO -           'python': 'c:/mozilla-build/python27/python.exe',
18:34:22     INFO -           'tooltool.py': ('c:/mozilla-build/python27/python.exe',
18:34:22     INFO -                           'C:/mozilla-build/tooltool.py'),
18:34:22     INFO -           'virtualenv': ('c:/mozilla-build/python27/python.exe',
18:34:22     INFO -                          'c:/mozilla-build/buildbotve/virtualenv.py')},
18:34:22     INFO -  'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
18:34:22     INFO -                 'http://pypi.pub.build.mozilla.org/pub'),
18:34:22     INFO -  'gecko_profile': False,
18:34:22     INFO -  'gecko_profile_interval': 0,
18:34:22     INFO -  'installer_path': 'installer.exe',
18:34:22     INFO -  'log_level': 'info',
18:34:22     INFO -  'log_name': 'talos',
18:34:22     INFO -  'log_to_console': True,
18:34:22     INFO -  'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
18:34:22     INFO -  'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
18:34:22     INFO -  'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
18:34:22     INFO -  'opt_config_files': (),
18:34:22     INFO -  'pip_index': False,
18:34:22     INFO -  'suite': 'dromaeojs-e10s',
18:34:22     INFO -  'system_bits': '32',
18:34:22     INFO -  'talos_extra_options': ('--webServer', 'localhost'),
18:34:22     INFO -  'title': 'T-W864-IX-031',
18:34:22     INFO -  'use_talos_json': True,
18:34:22     INFO -  'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
18:34:22     INFO -  'virtualenv_path': 'C:\\slave\\test\\build/venv',
18:34:22     INFO -  'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
18:34:22     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
18:34:22     INFO -  'work_dir': 'build'}
18:34:22     INFO - [mozharness: 2017-04-14 01:34:22.652000Z] Running clobber step.
18:34:22     INFO - Running pre-action listener: _resource_record_pre_action
18:34:22     INFO - Running main action method: clobber
18:34:22     INFO - rmtree: C:\slave\test\build
18:34:22     INFO - Using _rmtree_windows ...
18:34:22     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
18:37:51     INFO - Running post-action listener: _resource_record_post_action
18:37:51     INFO - [mozharness: 2017-04-14 01:37:51.729000Z] Finished clobber step (success)
18:37:51     INFO - [mozharness: 2017-04-14 01:37:51.729000Z] Running read-buildbot-config step.
18:37:51     INFO - Running pre-action listener: _resource_record_pre_action
18:37:51     INFO - Running main action method: read_buildbot_config
18:37:51     INFO - Using buildbot properties:
18:37:51     INFO - {
18:37:51     INFO -     "project": "", 
18:37:51     INFO -     "product": "firefox", 
18:37:51     INFO -     "script_repo_revision": "production", 
18:37:51     INFO -     "builddir": "mozilla-central_win8_64_test-dromaeojs-e10s", 
18:37:51     INFO -     "repository": "", 
18:37:51     INFO -     "buildername": "Windows 8 64-bit mozilla-central talos dromaeojs-e10s", 
18:37:51     INFO -     "buildid": "20170413172451", 
18:37:51     INFO -     "pgo_build": "False", 
18:37:51     INFO -     "basedir": "C:\\slave\\test", 
18:37:51     INFO -     "buildnumber": 76, 
18:37:51     INFO -     "slavename": "t-w864-ix-031", 
18:37:51     INFO -     "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 
18:37:51     INFO -     "platform": "win8_64", 
18:37:51     INFO -     "scheduler": "tests-mozilla-central-win64-talos", 
18:37:51     INFO -     "branch": "mozilla-central", 
18:37:51     INFO -     "repo_path": "mozilla-central", 
18:37:51     INFO -     "revision": "198effec6e11460e977f13e9cb83050a21a64d27", 
18:37:51     INFO -     "stage_platform": "win64", 
18:37:51     INFO -     "builduid": "398d5ab1413f41fa82aac857b42395f4", 
18:37:51     INFO -     "slavebuilddir": "test"
18:37:51     INFO - }
18:37:51     INFO - Found installer url https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip.
18:37:51     INFO - Running post-action listener: _resource_record_post_action
18:37:51     INFO - [mozharness: 2017-04-14 01:37:51.732000Z] Finished read-buildbot-config step (success)
18:37:51     INFO - [mozharness: 2017-04-14 01:37:51.732000Z] Running download-and-extract step.
18:37:51     INFO - Running pre-action listener: _resource_record_pre_action
18:37:51     INFO - Running main action method: download_and_extract
18:37:51     INFO - mkdir: C:\slave\test\build\tests
18:37:51     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:37:51     INFO - trying https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.test_packages.json
18:37:51     INFO - Downloading https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-55.0a1.en-US.win64.test_packages.json
18:37:51     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-55.0a1.en-US.win64.test_packages.json'}, attempt #1
18:37:52     INFO - Downloaded 1408 bytes.
18:37:52     INFO - Reading from file C:\slave\test\build\firefox-55.0a1.en-US.win64.test_packages.json
18:37:52     INFO - Using the following test package requirements:
18:37:52     INFO - {u'awsy': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -            u'firefox-55.0a1.en-US.win64.awsy.tests.zip'],
18:37:52     INFO -  u'common': [u'firefox-55.0a1.en-US.win64.common.tests.zip'],
18:37:52     INFO -  u'cppunittest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -                   u'firefox-55.0a1.en-US.win64.cppunittest.tests.zip'],
18:37:52     INFO -  u'gtest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -             u'firefox-55.0a1.en-US.win64.gtest.tests.zip'],
18:37:52     INFO -  u'jittest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -               u'jsshell-win64.zip'],
18:37:52     INFO -  u'mochitest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -                 u'firefox-55.0a1.en-US.win64.mochitest.tests.zip'],
18:37:52     INFO -  u'mozbase': [u'firefox-55.0a1.en-US.win64.common.tests.zip'],
18:37:52     INFO -  u'reftest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -               u'firefox-55.0a1.en-US.win64.reftest.tests.zip'],
18:37:52     INFO -  u'talos': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -             u'firefox-55.0a1.en-US.win64.talos.tests.zip'],
18:37:52     INFO -  u'web-platform': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -                    u'firefox-55.0a1.en-US.win64.web-platform.tests.zip'],
18:37:52     INFO -  u'xpcshell': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
18:37:52     INFO -                u'firefox-55.0a1.en-US.win64.xpcshell.tests.zip']}
18:37:52     INFO - Downloading packages: [u'firefox-55.0a1.en-US.win64.common.tests.zip'] for test suite category: common
18:37:52     INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip
18:37:52     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip'}, attempt #1
18:37:52     INFO - Fetch https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip into memory
18:37:54     INFO - Expected file size: 53668434
18:37:54     INFO - Obtained file size: 53668434
18:39:16     INFO - Downloading packages: [u'firefox-55.0a1.en-US.win64.common.tests.zip', u'firefox-55.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
18:39:16     INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip
18:39:16     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip'}, attempt #1
18:39:16     INFO - Fetch https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip into memory
18:39:18     INFO - Expected file size: 53668434
18:39:18     INFO - Obtained file size: 53668434
18:39:43     INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.talos.tests.zip
18:39:43     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.talos.tests.zip'}, attempt #1
18:39:43     INFO - Fetch https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.talos.tests.zip into memory
18:39:43     INFO - Expected file size: 14408853
18:39:43     INFO - Obtained file size: 14408853
18:40:01     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:01     INFO - trying https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
18:40:01     INFO - Downloading https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip to C:\slave\test\build\firefox-55.0a1.en-US.win64.zip
18:40:01     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-55.0a1.en-US.win64.zip'}, attempt #1
18:40:02     INFO - Downloaded 55662694 bytes.
18:40:02     INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
18:40:02     INFO - mkdir: C:\slave\test\properties
18:40:02     INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
18:40:02     INFO - Writing to file C:\slave\test\properties\build_url
18:40:02     INFO - Contents:
18:40:02     INFO -  build_url:https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
18:40:03     INFO - Running post-action listener: _resource_record_post_action
18:40:03     INFO - Running post-action listener: set_extra_try_arguments
18:40:03     INFO - [mozharness: 2017-04-14 01:40:03.454000Z] Finished download-and-extract step (success)
18:40:03     INFO - [mozharness: 2017-04-14 01:40:03.454000Z] Running populate-webroot step.
18:40:03     INFO - Running pre-action listener: _resource_record_pre_action
18:40:03     INFO - Running main action method: populate_webroot
18:40:03     INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
18:40:03     INFO -  u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
18:40:03     INFO -                     u'remote-tsvgx': {u'talos_options': [u'--noChrome',
18:40:03     INFO -                                                          u'--tppagecycles',
18:40:03     INFO -                                                          u'7'],
18:40:03     INFO -                                       u'tests': [u'tsvgm']}},
18:40:03     INFO -  u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                           u'tests': [u'tresize', u'tcanvasmark']},
18:40:03     INFO -              u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
18:40:03     INFO -              u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                             u'tests': [u'dromaeo_css', u'kraken']},
18:40:03     INFO -              u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
18:40:03     INFO -              u'g1': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                      u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                      u'tests': [u'tp5o_scroll', u'glterrain']},
18:40:03     INFO -              u'g1-e10s': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                           u'tests': [u'tp5o_scroll', u'glterrain']},
18:40:03     INFO -              u'g2': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                      u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                      u'tests': [u'damp', u'tps']},
18:40:03     INFO -              u'g2-e10s': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                           u'tests': [u'damp', u'tps']},
18:40:03     INFO -              u'g3': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                      u'tests': [u'dromaeo_dom']},
18:40:03     INFO -              u'g3-e10s': {u'tests': [u'dromaeo_dom']},
18:40:03     INFO -              u'g4': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                      u'tests': [u'basic_compositor_video', u'glvideo']},
18:40:03     INFO -              u'g4-e10s': {u'tests': [u'basic_compositor_video', u'glvideo']},
18:40:03     INFO -              u'other': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                         u'tests': [u'a11yr',
18:40:03     INFO -                                    u'ts_paint',
18:40:03     INFO -                                    u'tpaint',
18:40:03     INFO -                                    u'sessionrestore',
18:40:03     INFO -                                    u'sessionrestore_no_auto_restore',
18:40:03     INFO -                                    u'tabpaint']},
18:40:03     INFO -              u'other-e10s': {u'tests': [u'a11yr',
18:40:03     INFO -                                         u'ts_paint',
18:40:03     INFO -                                         u'tpaint',
18:40:03     INFO -                                         u'sessionrestore',
18:40:03     INFO -                                         u'sessionrestore_no_auto_restore',
18:40:03     INFO -                                         u'tabpaint']},
18:40:03     INFO -              u'other-e10s_l64': {u'tests': [u'a11yr',
18:40:03     INFO -                                             u'ts_paint',
18:40:03     INFO -                                             u'tpaint',
18:40:03     INFO -                                             u'sessionrestore',
18:40:03     INFO -                                             u'sessionrestore_no_auto_restore',
18:40:03     INFO -                                             u'tabpaint']},
18:40:03     INFO -              u'other-e10s_nol64': {u'tests': [u'a11yr',
18:40:03     INFO -                                               u'ts_paint',
18:40:03     INFO -                                               u'tpaint',
18:40:03     INFO -                                               u'sessionrestore',
18:40:03     INFO -                                               u'sessionrestore_no_auto_restore',
18:40:03     INFO -                                               u'tabpaint']},
18:40:03     INFO -              u'other_l64': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                             u'tests': [u'a11yr',
18:40:03     INFO -                                        u'ts_paint',
18:40:03     INFO -                                        u'tpaint',
18:40:03     INFO -                                        u'sessionrestore',
18:40:03     INFO -                                        u'sessionrestore_no_auto_restore',
18:40:03     INFO -                                        u'tabpaint']},
18:40:03     INFO -              u'other_nol64': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                               u'tests': [u'a11yr',
18:40:03     INFO -                                          u'ts_paint',
18:40:03     INFO -                                          u'tpaint',
18:40:03     INFO -                                          u'sessionrestore',
18:40:03     INFO -                                          u'sessionrestore_no_auto_restore',
18:40:03     INFO -                                          u'tabpaint']},
18:40:03     INFO -              u'perf-reftest': {u'tests': [u'bloom_basic',
18:40:03     INFO -                                           u'bloom_basic_ref']},
18:40:03     INFO -              u'perf-reftest-e10s': {u'tests': [u'bloom_basic',
18:40:03     INFO -                                                u'bloom_basic_ref']},
18:40:03     INFO -              u'svgr': {u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                        u'tests': [u'tsvgx',
18:40:03     INFO -                                   u'tsvgr_opacity',
18:40:03     INFO -                                   u'tart',
18:40:03     INFO -                                   u'tscrollx',
18:40:03     INFO -                                   u'cart',
18:40:03     INFO -                                   u'tsvg_static']},
18:40:03     INFO -              u'svgr-e10s': {u'tests': [u'tsvgx',
18:40:03     INFO -                                        u'tsvgr_opacity',
18:40:03     INFO -                                        u'tart',
18:40:03     INFO -                                        u'tscrollx',
18:40:03     INFO -                                        u'cart',
18:40:03     INFO -                                        u'tsvg_static']},
18:40:03     INFO -              u'tp5o': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                        u'talos_options': [u'--disable-e10s'],
18:40:03     INFO -                        u'tests': [u'tp5o']},
18:40:03     INFO -              u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                             u'tests': [u'tp5o']},
18:40:03     INFO -              u'xperf': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                         u'talos_options': [u'--disable-e10s',
18:40:03     INFO -                                            u'--xperf_path',
18:40:03     INFO -                                            u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
18:40:03     INFO -                         u'tests': [u'tp5n']},
18:40:03     INFO -              u'xperf-e10s': {u'pagesets_name': u'tp5n.zip',
18:40:03     INFO -                              u'talos_options': [u'--xperf_path',
18:40:03     INFO -                                                 u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
18:40:03     INFO -                              u'tests': [u'tp5n']}},
18:40:03     INFO -  u'talos.zip': {u'path': u'',
18:40:03     INFO -                 u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
18:40:03     INFO - Running post-action listener: _resource_record_post_action
18:40:03     INFO - [mozharness: 2017-04-14 01:40:03.525000Z] Finished populate-webroot step (success)
18:40:03     INFO - [mozharness: 2017-04-14 01:40:03.525000Z] Running create-virtualenv step.
18:40:03     INFO - Running pre-action listener: _resource_record_pre_action
18:40:03     INFO - Running main action method: create_virtualenv
18:40:03     INFO - Creating virtualenv C:\slave\test\build/venv
18:40:03     INFO - mkdir: C:\slave\test\build\venv\Scripts
18:40:03     INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
18:40:03  WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
18:40:03     INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build
18:40:03     INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
18:40:15     INFO -  New python executable in C:\slave\test\build/venv\Scripts\python.exe
18:40:19     INFO -  Installing distribute......................................................................................................................................................................................done.
18:40:20     INFO - Return code: 0
18:40:20     INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
18:40:20     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
18:40:21     INFO - Reading from file tmpfile_stdout
18:40:21     INFO - Output received:
18:40:21     INFO -  pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
18:40:21     INFO - Using _rmtree_windows ...
18:40:21     INFO - Using _rmtree_windows ...
18:40:21     INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
18:40:21     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:21     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:21     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:21     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:21     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:21     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
18:40:21     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
18:40:21     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:21     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:21     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:21     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:21     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:21     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:21     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:21     INFO -  'DCLOCATION': 'SCL3',
18:40:21     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:21     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:21     INFO -  'HOMEDRIVE': 'C:',
18:40:21     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:21     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:21     INFO -  'KTS_VERSION': '1.19c',
18:40:21     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:21     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:21     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:21     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:21     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:21     INFO -  'MOZ_NO_REMOTE': '1',
18:40:21     INFO -  'NO_EM_RESTART': '1',
18:40:21     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:21     INFO -  'OS': 'Windows_NT',
18:40:21     INFO -  'OURDRIVE': 'C:',
18:40:21     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:21     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:21     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:21     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:21     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:21     INFO -  'PROCESSOR_LEVEL': '6',
18:40:21     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:21     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:21     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:21     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:21     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:21     INFO -  'PROMPT': '$P$G',
18:40:21     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:21     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:21     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:21     INFO -  'PWD': 'C:\\slave\\test',
18:40:21     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:21     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:21     INFO -  'SYSTEMDRIVE': 'C:',
18:40:21     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:21     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:21     INFO -  'TEST1': 'testie',
18:40:21     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:21     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:21     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:21     INFO -  'USERNAME': 'cltbld',
18:40:21     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:21     INFO -  'WINDIR': 'C:\\windows',
18:40:21     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:22     INFO -  Ignoring indexes: http://pypi.python.org/simple/
18:40:22     INFO -  Downloading/unpacking pip>=1.5
18:40:26     INFO -    Running setup.py egg_info for package pip
18:40:26     INFO -      warning: no files found matching 'pip\cacert.pem'
18:40:26     INFO -      warning: no files found matching '*.html' under directory 'docs'
18:40:26     INFO -      warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
18:40:26     INFO -      no previously-included directories found matching 'docs\_build\_sources'
18:40:26     INFO -  Installing collected packages: pip
18:40:26     INFO -    Found existing installation: pip 0.8.2
18:40:26     INFO -      Uninstalling pip:
18:40:26     INFO -        Successfully uninstalled pip
18:40:26     INFO -    Running setup.py install for pip
18:40:26     INFO -      warning: no files found matching 'pip\cacert.pem'
18:40:26     INFO -      warning: no files found matching '*.html' under directory 'docs'
18:40:26     INFO -      warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
18:40:26     INFO -      no previously-included directories found matching 'docs\_build\_sources'
18:40:26     INFO -      Installing pip-script.py script to C:\slave\test\build\venv\Scripts
18:40:26     INFO -      Installing pip.exe script to C:\slave\test\build\venv\Scripts
18:40:26     INFO -      Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
18:40:26     INFO -      Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
18:40:26     INFO -      Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
18:40:26     INFO -      Installing pip2.exe script to C:\slave\test\build\venv\Scripts
18:40:26     INFO -  Successfully installed pip
18:40:26     INFO -  Cleaning up...
18:40:26     INFO - Return code: 0
18:40:26     INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
18:40:26     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:26     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:26     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:26     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:26     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:26     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build
18:40:26     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
18:40:26     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:26     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:26     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:26     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:26     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:26     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:26     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:26     INFO -  'DCLOCATION': 'SCL3',
18:40:26     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:26     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:26     INFO -  'HOMEDRIVE': 'C:',
18:40:26     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:26     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:26     INFO -  'KTS_VERSION': '1.19c',
18:40:26     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:26     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:26     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:26     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:26     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:26     INFO -  'MOZ_NO_REMOTE': '1',
18:40:26     INFO -  'NO_EM_RESTART': '1',
18:40:26     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:26     INFO -  'OS': 'Windows_NT',
18:40:26     INFO -  'OURDRIVE': 'C:',
18:40:26     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:26     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:26     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:26     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:26     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:26     INFO -  'PROCESSOR_LEVEL': '6',
18:40:26     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:26     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:26     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:26     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:26     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:26     INFO -  'PROMPT': '$P$G',
18:40:26     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:26     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:26     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:26     INFO -  'PWD': 'C:\\slave\\test',
18:40:26     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:26     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:26     INFO -  'SYSTEMDRIVE': 'C:',
18:40:26     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:26     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:26     INFO -  'TEST1': 'testie',
18:40:26     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:26     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:26     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:26     INFO -  'USERNAME': 'cltbld',
18:40:26     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:26     INFO -  'WINDIR': 'C:\\windows',
18:40:26     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:30     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:30     INFO -  Downloading/unpacking psutil>=3.1.1
18:40:30     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:30     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:31     INFO -  Installing collected packages: psutil
18:40:31     INFO -  Successfully installed psutil
18:40:31     INFO -  Cleaning up...
18:40:32     INFO - Return code: 0
18:40:32     INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
18:40:32     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:32     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:32     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:32     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:32     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:32     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build
18:40:32     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
18:40:32     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:32     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:32     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:32     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:32     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:32     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:32     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:32     INFO -  'DCLOCATION': 'SCL3',
18:40:32     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:32     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:32     INFO -  'HOMEDRIVE': 'C:',
18:40:32     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:32     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:32     INFO -  'KTS_VERSION': '1.19c',
18:40:32     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:32     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:32     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:32     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:32     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:32     INFO -  'MOZ_NO_REMOTE': '1',
18:40:32     INFO -  'NO_EM_RESTART': '1',
18:40:32     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:32     INFO -  'OS': 'Windows_NT',
18:40:32     INFO -  'OURDRIVE': 'C:',
18:40:32     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:32     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:32     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:32     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:32     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:32     INFO -  'PROCESSOR_LEVEL': '6',
18:40:32     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:32     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:32     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:32     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:32     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:32     INFO -  'PROMPT': '$P$G',
18:40:32     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:32     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:32     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:32     INFO -  'PWD': 'C:\\slave\\test',
18:40:32     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:32     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:32     INFO -  'SYSTEMDRIVE': 'C:',
18:40:32     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:32     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:32     INFO -  'TEST1': 'testie',
18:40:32     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:32     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:32     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:32     INFO -  'USERNAME': 'cltbld',
18:40:32     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:32     INFO -  'WINDIR': 'C:\\windows',
18:40:32     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:32     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:32     INFO -  Downloading/unpacking mozsystemmonitor==0.3
18:40:32     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:32     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:33     INFO -    Downloading mozsystemmonitor-0.3.tar.gz
18:40:33     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
18:40:33     INFO -  Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3)
18:40:33     INFO -  Installing collected packages: mozsystemmonitor
18:40:33     INFO -    Running setup.py install for mozsystemmonitor
18:40:34     INFO -  Successfully installed mozsystemmonitor
18:40:34     INFO -  Cleaning up...
18:40:34     INFO - Return code: 0
18:40:34     INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
18:40:34     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:34     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:34     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:34     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:34     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:34     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build
18:40:34     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
18:40:34     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:34     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:34     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:34     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:34     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:34     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:34     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:34     INFO -  'DCLOCATION': 'SCL3',
18:40:34     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:34     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:34     INFO -  'HOMEDRIVE': 'C:',
18:40:34     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:34     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:34     INFO -  'KTS_VERSION': '1.19c',
18:40:34     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:34     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:34     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:34     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:34     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:34     INFO -  'MOZ_NO_REMOTE': '1',
18:40:34     INFO -  'NO_EM_RESTART': '1',
18:40:34     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:34     INFO -  'OS': 'Windows_NT',
18:40:34     INFO -  'OURDRIVE': 'C:',
18:40:34     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:34     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:34     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:34     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:34     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:34     INFO -  'PROCESSOR_LEVEL': '6',
18:40:34     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:34     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:34     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:34     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:34     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:34     INFO -  'PROMPT': '$P$G',
18:40:34     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:34     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:34     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:34     INFO -  'PWD': 'C:\\slave\\test',
18:40:34     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:34     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:34     INFO -  'SYSTEMDRIVE': 'C:',
18:40:34     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:34     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:34     INFO -  'TEST1': 'testie',
18:40:34     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:34     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:34     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:34     INFO -  'USERNAME': 'cltbld',
18:40:34     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:34     INFO -  'WINDIR': 'C:\\windows',
18:40:34     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:34     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:34     INFO -  Downloading/unpacking jsonschema==2.5.1
18:40:34     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:34     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:35     INFO -    Downloading jsonschema-2.5.1-py2.py3-none-any.whl
18:40:35     INFO -  Downloading/unpacking functools32 (from jsonschema==2.5.1)
18:40:35     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:35     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:36     INFO -    Downloading functools32-3.2.3-2.tar.gz
18:40:36     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
18:40:36     INFO -      warning: no files found matching '*.txt'
18:40:36     INFO -      no previously-included directories found matching 'build'
18:40:36     INFO -      no previously-included directories found matching 'dist'
18:40:36     INFO -      no previously-included directories found matching '.git*'
18:40:36     INFO -  Installing collected packages: jsonschema, functools32
18:40:36     INFO -    Running setup.py install for functools32
18:40:36     INFO -      warning: no files found matching '*.txt'
18:40:36     INFO -      no previously-included directories found matching 'build'
18:40:36     INFO -      no previously-included directories found matching 'dist'
18:40:36     INFO -      no previously-included directories found matching '.git*'
18:40:36     INFO -  Successfully installed jsonschema functools32
18:40:36     INFO -  Cleaning up...
18:40:36     INFO - Return code: 0
18:40:36     INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
18:40:36     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:36     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:36     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:36     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:36     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:36     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build
18:40:36     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
18:40:36     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:36     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:36     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:36     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:36     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:36     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:36     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:36     INFO -  'DCLOCATION': 'SCL3',
18:40:36     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:36     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:36     INFO -  'HOMEDRIVE': 'C:',
18:40:36     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:36     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:36     INFO -  'KTS_VERSION': '1.19c',
18:40:36     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:36     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:36     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:36     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:36     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:36     INFO -  'MOZ_NO_REMOTE': '1',
18:40:36     INFO -  'NO_EM_RESTART': '1',
18:40:36     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:36     INFO -  'OS': 'Windows_NT',
18:40:36     INFO -  'OURDRIVE': 'C:',
18:40:36     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:36     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:36     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:36     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:36     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:36     INFO -  'PROCESSOR_LEVEL': '6',
18:40:36     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:36     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:36     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:36     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:36     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:36     INFO -  'PROMPT': '$P$G',
18:40:36     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:36     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:36     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:36     INFO -  'PWD': 'C:\\slave\\test',
18:40:36     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:36     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:36     INFO -  'SYSTEMDRIVE': 'C:',
18:40:36     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:36     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:36     INFO -  'TEST1': 'testie',
18:40:36     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:36     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:36     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:36     INFO -  'USERNAME': 'cltbld',
18:40:36     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:36     INFO -  'WINDIR': 'C:\\windows',
18:40:36     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:37     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:37     INFO -  Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
18:40:37     INFO -  Cleaning up...
18:40:37     INFO - Return code: 0
18:40:37     INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
18:40:37     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:37     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:37     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:37     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:37     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:37     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build
18:40:37     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
18:40:37     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:37     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:37     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:37     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:37     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:37     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:37     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:37     INFO -  'DCLOCATION': 'SCL3',
18:40:37     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:37     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:37     INFO -  'HOMEDRIVE': 'C:',
18:40:37     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:37     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:37     INFO -  'KTS_VERSION': '1.19c',
18:40:37     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:37     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:37     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:37     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:37     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:37     INFO -  'MOZ_NO_REMOTE': '1',
18:40:37     INFO -  'NO_EM_RESTART': '1',
18:40:37     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:37     INFO -  'OS': 'Windows_NT',
18:40:37     INFO -  'OURDRIVE': 'C:',
18:40:37     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:37     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:37     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:37     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:37     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:37     INFO -  'PROCESSOR_LEVEL': '6',
18:40:37     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:37     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:37     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:37     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:37     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:37     INFO -  'PROMPT': '$P$G',
18:40:37     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:37     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:37     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:37     INFO -  'PWD': 'C:\\slave\\test',
18:40:37     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:37     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:37     INFO -  'SYSTEMDRIVE': 'C:',
18:40:37     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:37     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:37     INFO -  'TEST1': 'testie',
18:40:37     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:37     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:37     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:37     INFO -  'USERNAME': 'cltbld',
18:40:37     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:37     INFO -  'WINDIR': 'C:\\windows',
18:40:37     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:37     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:37     INFO -  Downloading/unpacking blobuploader==1.2.4
18:40:37     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:37     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:38     INFO -    Downloading blobuploader-1.2.4.tar.gz
18:40:38     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
18:40:38     INFO -  Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
18:40:38     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:38     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:38     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
18:40:39     INFO -  Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
18:40:39     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:39     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:39     INFO -    Downloading docopt-0.6.1.tar.gz
18:40:39     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
18:40:39     INFO -  Installing collected packages: blobuploader, requests, docopt
18:40:39     INFO -    Running setup.py install for blobuploader
18:40:39     INFO -    Running setup.py install for requests
18:40:40     INFO -    Running setup.py install for docopt
18:40:40     INFO -  Successfully installed blobuploader requests docopt
18:40:40     INFO -  Cleaning up...
18:40:41     INFO - Return code: 0
18:40:41     INFO - Installing None into virtualenv C:\slave\test\build/venv
18:40:41     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:41     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:41     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:41     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:41     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:41     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
18:40:41     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
18:40:41     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:41     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:41     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:41     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:41     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:41     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:41     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:41     INFO -  'DCLOCATION': 'SCL3',
18:40:41     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:41     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:41     INFO -  'HOMEDRIVE': 'C:',
18:40:41     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:41     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:41     INFO -  'KTS_VERSION': '1.19c',
18:40:41     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:41     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:41     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:41     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:41     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:41     INFO -  'MOZ_NO_REMOTE': '1',
18:40:41     INFO -  'NO_EM_RESTART': '1',
18:40:41     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:41     INFO -  'OS': 'Windows_NT',
18:40:41     INFO -  'OURDRIVE': 'C:',
18:40:41     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:41     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:41     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:41     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:41     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:41     INFO -  'PROCESSOR_LEVEL': '6',
18:40:41     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:41     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:41     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:41     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:41     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:41     INFO -  'PROMPT': '$P$G',
18:40:41     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:41     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:41     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:41     INFO -  'PWD': 'C:\\slave\\test',
18:40:41     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:41     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:41     INFO -  'SYSTEMDRIVE': 'C:',
18:40:41     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:41     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:41     INFO -  'TEST1': 'testie',
18:40:41     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:41     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:41     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:41     INFO -  'USERNAME': 'cltbld',
18:40:41     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:41     INFO -  'WINDIR': 'C:\\windows',
18:40:41     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:41     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:41     INFO -  Unpacking c:\slave\test\build\tests\mozbase\manifestparser
18:40:41     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-syju_g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
18:40:41     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozcrash
18:40:41     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gxwetg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdebug
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x_ozdx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdevice
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gbzb4s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozfile
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_ls96n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5iezwd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinfo
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l9hbc8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinstall
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8zenhl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozleak
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-129pqs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozlog
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jvfljk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
18:40:42     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moznetwork
18:40:42     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dknggx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
18:40:43     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprocess
18:40:43     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gd79iu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
18:40:43     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprofile
18:40:43     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jwepkx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
18:40:43     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozrunner
18:40:43     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-75_c3a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
18:40:43     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
18:40:43     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1uyjxz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
18:40:43     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moztest
18:40:43     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tvbmkg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
18:40:43     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozversion
18:40:43     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2ierjg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
18:40:43     INFO -  Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
18:40:43     INFO -    Running setup.py install for manifestparser
18:40:44     INFO -      Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
18:40:44     INFO -      Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
18:40:44     INFO -    Running setup.py install for mozcrash
18:40:44     INFO -    Running setup.py install for mozdebug
18:40:45     INFO -    Running setup.py install for mozdevice
18:40:45     INFO -      Installing dm-script.py script to C:\slave\test\build\venv\Scripts
18:40:45     INFO -      Installing dm.exe script to C:\slave\test\build\venv\Scripts
18:40:45     INFO -    Running setup.py install for mozfile
18:40:46     INFO -    Running setup.py install for mozhttpd
18:40:46     INFO -      Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
18:40:46     INFO -      Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
18:40:46     INFO -    Running setup.py install for mozinfo
18:40:46     INFO -      Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
18:40:46     INFO -      Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -    Running setup.py install for mozInstall
18:40:47     INFO -      Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -    Running setup.py install for mozleak
18:40:47     INFO -    Running setup.py install for mozlog
18:40:47     INFO -      Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
18:40:47     INFO -      Installing structlog.exe script to C:\slave\test\build\venv\Scripts
18:40:48     INFO -    Running setup.py install for moznetwork
18:40:48     INFO -      Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
18:40:48     INFO -      Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
18:40:49     INFO -    Running setup.py install for mozprocess
18:40:49     INFO -    Running setup.py install for mozprofile
18:40:49     INFO -      Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
18:40:49     INFO -      Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
18:40:49     INFO -      Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
18:40:49     INFO -      Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
18:40:49     INFO -      Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
18:40:49     INFO -      Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
18:40:50     INFO -    Running setup.py install for mozrunner
18:40:50     INFO -      Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
18:40:50     INFO -      Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
18:40:51     INFO -    Running setup.py install for mozscreenshot
18:40:51     INFO -    Running setup.py install for moztest
18:40:52     INFO -    Running setup.py install for mozversion
18:40:52     INFO -      Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
18:40:52     INFO -      Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
18:40:52     INFO -  Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
18:40:52     INFO -  Cleaning up...
18:40:52     INFO - Return code: 0
18:40:52     INFO - Installing None into virtualenv C:\slave\test\build/venv
18:40:52     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:52     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:52     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:52     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:52     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:52     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
18:40:52     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
18:40:52     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:52     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:52     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:52     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:52     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:52     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:52     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:52     INFO -  'DCLOCATION': 'SCL3',
18:40:52     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:52     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:52     INFO -  'HOMEDRIVE': 'C:',
18:40:52     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:52     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:52     INFO -  'KTS_VERSION': '1.19c',
18:40:52     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:52     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:52     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:52     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:52     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:52     INFO -  'MOZ_NO_REMOTE': '1',
18:40:52     INFO -  'NO_EM_RESTART': '1',
18:40:52     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:52     INFO -  'OS': 'Windows_NT',
18:40:52     INFO -  'OURDRIVE': 'C:',
18:40:52     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:52     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:52     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:52     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:52     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:52     INFO -  'PROCESSOR_LEVEL': '6',
18:40:52     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:52     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:52     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:52     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:52     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:52     INFO -  'PROMPT': '$P$G',
18:40:52     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:52     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:52     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:52     INFO -  'PWD': 'C:\\slave\\test',
18:40:52     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:52     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:52     INFO -  'SYSTEMDRIVE': 'C:',
18:40:52     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:52     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:52     INFO -  'TEST1': 'testie',
18:40:52     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:52     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:52     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:52     INFO -  'USERNAME': 'cltbld',
18:40:52     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:52     INFO -  'WINDIR': 'C:\\windows',
18:40:52     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:52     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:52     INFO -  Unpacking c:\slave\test\build\tests\mozbase\manifestparser
18:40:52     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tfbw_c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
18:40:52     INFO -    Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1))
18:40:52     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozcrash
18:40:52     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ketqgg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
18:40:52     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
18:40:52     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdebug
18:40:52     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a9_2z1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdevice
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jqs2el-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozfile
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hrqpxm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2snjoj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinfo
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gkwxxp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinstall
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xykwux-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozleak
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fdz5rt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozlog
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xgddvj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
18:40:53     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
18:40:53     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moznetwork
18:40:53     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8v6asa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11))
18:40:54     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprocess
18:40:54     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kpvlme-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12))
18:40:54     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprofile
18:40:54     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qefh3g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13))
18:40:54     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozrunner
18:40:54     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jpqlrh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
18:40:54     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
18:40:54     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-avoaln-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15))
18:40:54     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moztest
18:40:54     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hsbur_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16))
18:40:54     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozversion
18:40:54     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tikhjc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
18:40:54     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17))
18:40:54     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
18:40:54     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
18:40:54     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
18:40:54     INFO -  Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.50->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
18:40:54     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.50->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
18:40:54     INFO -  Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
18:40:54     INFO -    http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
18:40:54     INFO -    http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
18:40:55     INFO -    Downloading blessings-1.6.tar.gz
18:40:55     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
18:40:56     INFO -  Installing collected packages: blessings
18:40:56     INFO -    Running setup.py install for blessings
18:40:56     INFO -  Successfully installed blessings
18:40:56     INFO -  Cleaning up...
18:40:59     INFO - Return code: 0
18:40:59     INFO - Done creating virtualenv C:\slave\test\build/venv.
18:40:59     INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
18:40:59     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
18:40:59     INFO - Reading from file tmpfile_stdout
18:40:59     INFO - Using _rmtree_windows ...
18:40:59     INFO - Using _rmtree_windows ...
18:40:59     INFO - Current package versions:
18:40:59     INFO -   blessings == 1.6
18:40:59     INFO -   blobuploader == 1.2.4
18:40:59     INFO -   docopt == 0.6.1
18:40:59     INFO -   functools32 == 3.2.3-2
18:40:59     INFO -   jsonschema == 2.5.1
18:40:59     INFO -   manifestparser == 1.1
18:40:59     INFO -   mozInstall == 1.12
18:40:59     INFO -   mozcrash == 1.0
18:40:59     INFO -   mozdebug == 0.1
18:40:59     INFO -   mozdevice == 0.50
18:40:59     INFO -   mozfile == 1.2
18:40:59     INFO -   mozhttpd == 0.7
18:40:59     INFO -   mozinfo == 0.9
18:40:59     INFO -   mozleak == 0.1
18:40:59     INFO -   mozlog == 3.4
18:40:59     INFO -   moznetwork == 0.27
18:40:59     INFO -   mozprocess == 0.25
18:40:59     INFO -   mozprofile == 0.28
18:40:59     INFO -   mozrunner == 6.13
18:40:59     INFO -   mozscreenshot == 0.1
18:40:59     INFO -   mozsystemmonitor == 0.3
18:40:59     INFO -   moztest == 0.8
18:40:59     INFO -   mozversion == 1.4
18:40:59     INFO -   psutil == 3.1.1
18:40:59     INFO -   requests == 1.2.3
18:40:59     INFO - Installing None into virtualenv C:\slave\test\build/venv
18:40:59     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:59     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:59     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:59     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:59     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:59     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos
18:40:59     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
18:40:59     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:59     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:59     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:59     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:59     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:59     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:59     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:59     INFO -  'DCLOCATION': 'SCL3',
18:40:59     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:59     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:59     INFO -  'HOMEDRIVE': 'C:',
18:40:59     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:59     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:59     INFO -  'KTS_VERSION': '1.19c',
18:40:59     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:59     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:59     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:59     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:59     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:59     INFO -  'MOZ_NO_REMOTE': '1',
18:40:59     INFO -  'NO_EM_RESTART': '1',
18:40:59     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:59     INFO -  'OS': 'Windows_NT',
18:40:59     INFO -  'OURDRIVE': 'C:',
18:40:59     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:59     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:59     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:59     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:59     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:59     INFO -  'PROCESSOR_LEVEL': '6',
18:40:59     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:59     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:59     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:59     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:59     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:59     INFO -  'PROMPT': '$P$G',
18:40:59     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:59     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:59     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:59     INFO -  'PWD': 'C:\\slave\\test',
18:40:59     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:59     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:59     INFO -  'SYSTEMDRIVE': 'C:',
18:40:59     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:59     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:59     INFO -  'TEST1': 'testie',
18:40:59     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:59     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:59     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:59     INFO -  'USERNAME': 'cltbld',
18:40:59     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:59     INFO -  'WINDIR': 'C:\\windows',
18:40:59     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:40:59     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
18:40:59     INFO -  Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4))
18:40:59     INFO -  Cleaning up...
18:40:59     INFO - Return code: 0
18:40:59     INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
18:40:59     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:59     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
18:40:59     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:40:59     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
18:40:59     INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022A3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028B5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243D750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-031', 'USERDOMAIN': 'T-W864-IX-031', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-031', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
18:40:59     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build
18:40:59     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
18:40:59     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:40:59     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:40:59     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:40:59     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:40:59     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:40:59     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:40:59     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:40:59     INFO -  'DCLOCATION': 'SCL3',
18:40:59     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:40:59     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:40:59     INFO -  'HOMEDRIVE': 'C:',
18:40:59     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:40:59     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:40:59     INFO -  'KTS_VERSION': '1.19c',
18:40:59     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:40:59     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:40:59     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:40:59     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:40:59     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:40:59     INFO -  'MOZ_NO_REMOTE': '1',
18:40:59     INFO -  'NO_EM_RESTART': '1',
18:40:59     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:40:59     INFO -  'OS': 'Windows_NT',
18:40:59     INFO -  'OURDRIVE': 'C:',
18:40:59     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:40:59     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:40:59     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:40:59     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:40:59     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:40:59     INFO -  'PROCESSOR_LEVEL': '6',
18:40:59     INFO -  'PROCESSOR_REVISION': '1e05',
18:40:59     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:40:59     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:40:59     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:40:59     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:40:59     INFO -  'PROMPT': '$P$G',
18:40:59     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:40:59     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:40:59     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:40:59     INFO -  'PWD': 'C:\\slave\\test',
18:40:59     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:40:59     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:40:59     INFO -  'SYSTEMDRIVE': 'C:',
18:40:59     INFO -  'SYSTEMROOT': 'C:\\windows',
18:40:59     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:59     INFO -  'TEST1': 'testie',
18:40:59     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:40:59     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:40:59     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:40:59     INFO -  'USERNAME': 'cltbld',
18:40:59     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:40:59     INFO -  'WINDIR': 'C:\\windows',
18:40:59     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:41:00     INFO -  Ignoring indexes: https://pypi.python.org/simple/
18:41:00     INFO -  Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
18:41:00     INFO -  Cleaning up...
18:41:00     INFO - Return code: 0
18:41:00     INFO - Running post-action listener: _resource_record_post_action
18:41:00     INFO - Running post-action listener: _start_resource_monitoring
18:41:00     INFO - Starting resource monitoring.
18:41:00     INFO - [mozharness: 2017-04-14 01:41:00.368000Z] Finished create-virtualenv step (success)
18:41:00     INFO - [mozharness: 2017-04-14 01:41:00.368000Z] Running install step.
18:41:00     INFO - Running pre-action listener: _resource_record_pre_action
18:41:00     INFO - Running main action method: install
18:41:00     INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
18:41:00     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
18:41:00     INFO - Reading from file tmpfile_stdout
18:41:00     INFO - Using _rmtree_windows ...
18:41:00     INFO - Using _rmtree_windows ...
18:41:00     INFO - Detecting whether we're running mozinstall >=1.0...
18:41:00     INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
18:41:00     INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
18:41:00     INFO - Reading from file tmpfile_stdout
18:41:00     INFO - Output received:
18:41:00     INFO -  Usage: mozinstall-script.py [options] installer
18:41:00     INFO -  Options:
18:41:00     INFO -    -h, --help            show this help message and exit
18:41:00     INFO -    -d DEST, --destination=DEST
18:41:00     INFO -                          Directory to install application into. [default:
18:41:00     INFO -                          "C:\slave\test"]
18:41:00     INFO -    --app=APP             Application being installed. [default: firefox]
18:41:00     INFO - Using _rmtree_windows ...
18:41:00     INFO - Using _rmtree_windows ...
18:41:00     INFO - mkdir: C:\slave\test\build\application
18:41:00     INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-55.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
18:41:00     INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-55.0a1.en-US.win64.zip --destination C:\slave\test\build\application
ProcessManager NOT managing child processes
18:41:02     INFO - Reading from file tmpfile_stdout
18:41:02     INFO - Output received:
18:41:02     INFO -  C:\slave\test\build\application\firefox\firefox.exe
18:41:02     INFO - Using _rmtree_windows ...
18:41:02     INFO - Using _rmtree_windows ...
18:41:02     INFO - Running post-action listener: _resource_record_post_action
18:41:02     INFO - [mozharness: 2017-04-14 01:41:02.375000Z] Finished install step (success)
18:41:02     INFO - [mozharness: 2017-04-14 01:41:02.375000Z] Running run-tests step.
18:41:02     INFO - Running pre-action listener: _resource_record_pre_action
18:41:02     INFO - Running main action method: run_tests
18:41:02     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
18:41:02     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
18:41:02     INFO -  Python 2.7.3
18:41:02     INFO - Return code: 0
18:41:02     INFO - grabbing minidump binary from tooltool
18:41:02     INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
18:41:02     INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028C00C8>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DAA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023E35C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
18:41:02     INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build
18:41:02     INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o
18:41:02     INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600
ProcessManager UNABLE to use job objects to manage child processes
18:41:02     INFO -  INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
18:41:02     INFO -  INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpypaxna
18:41:02     INFO -  INFO - File integrity verified, renaming tmpypaxna to win32-minidump_stackwalk.exe
18:41:02     INFO - Return code: 0
18:41:02     INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
18:41:02     INFO - mkdir: C:\slave\test\build\blobber_upload_dir
18:41:02     INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
18:41:02     INFO - ENV: RUST_BACKTRACE is now 1
18:41:02     INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
18:41:02     INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
18:41:02     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] in C:\slave\test\build
18:41:02     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log
18:41:02     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
18:41:02     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Roaming',
18:41:02     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
18:41:02     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
18:41:02     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
18:41:02     INFO -  'COMPUTERNAME': 'T-W864-IX-031',
18:41:02     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
18:41:02     INFO -  'DCLOCATION': 'SCL3',
18:41:02     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
18:41:02     INFO -  'FP_NO_HOST_CHECK': 'NO',
18:41:02     INFO -  'HOMEDRIVE': 'C:',
18:41:02     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-031',
18:41:02     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
18:41:02     INFO -  'KTS_VERSION': '1.19c',
18:41:02     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-031\\AppData\\Local',
18:41:02     INFO -  'LOGONSERVER': '\\\\T-W864-IX-031',
18:41:02     INFO -  'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
18:41:02     INFO -  'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
18:41:02     INFO -  'MONDIR': 'C:\\Monitor_config\\',
18:41:02     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
18:41:02     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
18:41:02     INFO -  'MOZ_NO_REMOTE': '1',
18:41:02     INFO -  'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
18:41:02     INFO -  'NO_EM_RESTART': '1',
18:41:02     INFO -  'NUMBER_OF_PROCESSORS': '8',
18:41:02     INFO -  'OS': 'Windows_NT',
18:41:02     INFO -  'OURDRIVE': 'C:',
18:41:02     INFO -  'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;',
18:41:02     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
18:41:02     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
18:41:02     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
18:41:02     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
18:41:02     INFO -  'PROCESSOR_LEVEL': '6',
18:41:02     INFO -  'PROCESSOR_REVISION': '1e05',
18:41:02     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
18:41:02     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
18:41:02     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
18:41:02     INFO -  'PROGRAMW6432': 'C:\\Program Files',
18:41:02     INFO -  'PROMPT': '$P$G',
18:41:02     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
18:41:02     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
18:41:02     INFO -  'PUBLIC': 'C:\\Users\\Public',
18:41:02     INFO -  'PWD': 'C:\\slave\\test',
18:41:02     INFO -  'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
18:41:02     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
18:41:02     INFO -  'RUST_BACKTRACE': '1',
18:41:02     INFO -  'SLAVEDIR': 'C:\\slave\\',
18:41:02     INFO -  'SYSTEMDRIVE': 'C:',
18:41:02     INFO -  'SYSTEMROOT': 'C:\\windows',
18:41:02     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:41:02     INFO -  'TEST1': 'testie',
18:41:02     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
18:41:02     INFO -  'USERDOMAIN': 'T-W864-IX-031',
18:41:02     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-031',
18:41:02     INFO -  'USERNAME': 'cltbld',
18:41:02     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-031',
18:41:02     INFO -  'WINDIR': 'C:\\windows',
18:41:02     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
18:41:02     INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] with output_timeout 3600
ProcessManager NOT managing child processes
ProcessManager UNABLE to use job objects to manage child processes
18:41:03     INFO -  mozversion application_buildid: 20170413172451
18:41:03     INFO -  mozversion application_changeset: 198effec6e11460e977f13e9cb83050a21a64d27
18:41:03     INFO -  mozversion application_display_name: Nightly
18:41:03     INFO -  mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
18:41:03     INFO -  mozversion application_name: Firefox
18:41:03     INFO -  mozversion application_remotingname: firefox
18:41:03     INFO -  mozversion application_repository: https://hg.mozilla.org/mozilla-central
18:41:03     INFO -  mozversion application_vendor: Mozilla
18:41:03     INFO -  mozversion application_version: 55.0a1
18:41:03     INFO -  mozversion platform_buildid: 20170413172451
18:41:03     INFO -  mozversion platform_changeset: 198effec6e11460e977f13e9cb83050a21a64d27
18:41:03     INFO -  mozversion platform_repository: https://hg.mozilla.org/mozilla-central
18:41:03     INFO -  mozversion platform_version: 55.0a1
18:41:03     INFO -  using testdate: 1492134063
18:41:03     INFO -  actual date: 1492134063
18:41:03     INFO -  starting webserver on 'localhost:49274'
18:41:03     INFO -  SUITE-START | Running 2 tests
18:41:03     INFO -  TEST-START | dromaeo_css
18:41:03     INFO -  operating with platform_type : w8_
18:41:03     INFO -  Initialising browser for dromaeo_css test...
18:41:03     INFO -  TEST-INFO | started process 2708 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp2cjdkj\profile http://localhost:49274/getInfo.html)
18:41:12     INFO -  PID 2708 | __metrics	Screen width/height:1600/1200
18:41:12     INFO -  PID 2708 | 	colorDepth:24
18:41:12     INFO -  PID 2708 | 	Browser inner width/height: 1010/676
18:41:12     INFO -  PID 2708 | __metrics
18:41:14     INFO -  PID 2708 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:41:14     INFO -  PID 2708 | [GPU 1332] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:14     INFO -  PID 2708 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:41:14    ERROR -  PID 2708 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined
18:41:14     INFO -  PID 2708 | [GPU 1332] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:14     INFO -  PID 2708 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:41:14     INFO -  PID 2708 | [Child 3728] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:14     INFO -  PID 2708 | [Child 3728] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:14     INFO -  PID 2708 | [GPU 1332] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:14     INFO -  PID 2708 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:41:14     INFO -  PID 2708 | [Child 852] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:14     INFO -  PID 2708 | [Child 852] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:41:15     INFO -  PID 2708 | [GFX1-]: Failed to OpenSharedResource for SyncObjectD3D11: 0x88760873
18:41:15     INFO -  PID 2708 | [GFX1 4]: Without device reset: 0x88760873
18:41:16     INFO -  PID 2708 |
18:41:16     INFO -  PID 2708 | ###!!! [Child][MessageChannel::SendAndWait] Error: Channel error: cannot send/recv
18:41:16     INFO -  PID 2708 |
18:41:16     INFO -  TEST-INFO | 2708: exit 0
18:41:16     INFO -  Browser initialized.
18:41:16     INFO -  Running cycle 1/1 for dromaeo_css test...
18:41:16     INFO -  TEST-INFO | started process 2520 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp2cjdkj\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
18:41:28     INFO -  PID 2520 | RSS: Main: 158527488
18:41:28     INFO -  PID 2520 |
18:44:29     INFO -  PID 2520 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html)
18:44:31     INFO -  PID 2520 | RSS: Main: 135135232
18:44:31     INFO -  PID 2520 |
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | A coding exception was thrown and uncaught in a Task.
18:46:18     INFO -  PID 2520 |
18:46:18    ERROR -  PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource.
18:46:18     INFO -  PID 2520 | Full stack:
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | A coding exception was thrown and uncaught in a Task.
18:46:18     INFO -  PID 2520 |
18:46:18    ERROR -  PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource.
18:46:18     INFO -  PID 2520 | Full stack:
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | A coding exception was thrown and uncaught in a Task.
18:46:18     INFO -  PID 2520 |
18:46:18    ERROR -  PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource.
18:46:18     INFO -  PID 2520 | Full stack:
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | *************************
18:46:18     INFO -  PID 2520 | A coding exception was thrown and uncaught in a Task.
18:46:18     INFO -  PID 2520 |
18:46:18    ERROR -  PID 2520 | Full message: TypeError: NetworkError when attempting to fetch resource.
18:46:18     INFO -  PID 2520 | Full stack:
18:46:18     INFO -  PID 2520 | *************************
18:47:32     INFO -  PID 2520 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html)
18:47:33     INFO -  PID 2520 | RSS: Main: 92938240
18:47:33     INFO -  PID 2520 |
18:50:35     INFO -  PID 2520 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html)
18:50:35     INFO -  PID 2520 | RSS: Main: 99241984
18:50:35     INFO -  PID 2520 |
18:50:35     INFO -  PID 2520 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:53:37     INFO -  PID 2520 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html)
18:53:38     INFO -  PID 2520 | RSS: Main: 89280512
18:53:38     INFO -  PID 2520 |
18:56:40     INFO -  PID 2520 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html)
18:56:41     INFO -  PID 2520 | RSS: Main: 108916736
18:56:41     INFO -  PID 2520 |
18:59:42     INFO -  PID 2520 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html)
18:59:43     INFO -  PID 2520 | RSS: Main: 92811264
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | __start_tp_report
18:59:43     INFO -  PID 2520 | _x_x_mozilla_page_load
18:59:43     INFO -  PID 2520 | _x_x_mozilla_page_load_details
18:59:43     INFO -  PID 2520 | |i|pagename|runs|
18:59:43     INFO -  PID 2520 | |0;dojo.html;2889.1043776429306;2898.681145074043;2916.387558612691;2939.706029397061;2945.293129648884;5070.264811602316;5076.289319495264;5085.6948583084995;5101.056304583654;5110.28456016158;5012.523810238031;5089.414717307511;5089.541941225289;5120.974395128019;5139.049275883964;4606.424196975378;4609.170349337118;4657.534246575349;4671.836485723001;4705.55297246761;4636.281376386649;4642.974695538554;4668.089722504113;4677.859664210079;4722.409698787652;4613.354130421743;4651.906961860761;4655.953440465602;4661.160991021615;4706.929396059062;4462.426132796549;4492.73043617384;4513.210188217049;4538.568835960578;4615.676902616819;4554.157480866051;4573.451185857685;4581.427321584802;4590.839320623795;4592.770361481913;4907.944791869765;4952.232403977389;5008.549230569266;5033.597312215051;5038.697678139323;5256.658317209369;5324.254604355393;5360.973195133999;5384.542313903323;5406.378266499363;5353.732313384316;5413.918791218135;5422.40353561108;5442.537384322298;5467.343918729738;4921.409430868247;4959.876003099951;4979.551840334351;5008.348914641109;5014.824481143215;5442.782288708487;5448;5506.339239291311;5518;5548.805791797348;5243;5263.0789611818545;5302.655327403706;5350.705711185922;5355.437679043722;5298.496642818926;5359.410464848864;5393.6224464287125;5419.34967803866;5426.8371948841595;5314.946850531445;5322.042032434199;5332.306800116037;5387.0841956867425;5387.218853266255;5111.309973153651;5125.026245013435;5238.214267859851;5246.658967167122;5251.842444726664;3506.50908872758;3515.1387909962223;3519;3530.6645868642436;3558.87543935961;3279.2293810954407;3286.1620286826706;3297.0932993427;3308.5698859148156;3317.2204531934976;4998.525140111757;5009.774560144802;5015.774290156952;5032.798688052437;5070.7464626768515;5297.655652382583;5316.627836051517;5372.221027950925;5373.247745315659;5396.703181324986;4966.90066198674;4974.850754477371;4983.103041452501;4986.177280748636;5006.3992320921725;4470.619997300266;4471.8434854779925;4506.774661266923;4515.390422293014;4552.6130278926;5511.311086114236;5512.39363670004;5517.917231241454;5525.226468294442;5551.3893471718075;5376.758045888023;5434.782608695607;5456.727163641882;5475.288212532345;5496.7526461310135;5378.193271009223;5424.050791111618;5429.294191755204;5434.402215756185;5437.782488700408;5200.817971371135;5370.812021579226;5381.219723140044;5408.161734931092;5432.619716619799;5439;5447.346318441812;5460.071787796005;5460.481254280837;5467.863303417446;5197;5291.444398338119;5301.602379821452;5303.708296043755;5364.356277246756;5207.3230480037355;5262.947370526245;5277.762500687401;5322.946770532245;5337.946620533745;5180.222966555047;5207.3490813648295;5214.426413094632;5230.581553475637;5260.815871444481;5105.948940510547;5298.28473156119;5317.494837990384;5323.441038690882;5343.251944727819;5147.124988751846;5199.74001299941;5268.209768534751;5290.074237008585;5303.098473259478
18:59:43     INFO -  PID 2520 | |1;ext.html;684.9383555480006;726.4007194064897;752.7440670172142;1026.948652567372;1054.3463052907198;30104.698953010462;30872.38255234894;30874.38251234974;30905.69094309056;31074.2231444214;31733.523997140062;31882.84058579704;32049.5192572111;32117.357652846928;32150.196245093884;6739.359760822714;6832.692528836202;6911.6544172791155;6922.792316230496;6975.930240697604;6948.33990770876;6997.930020699779;7016.298370162968;7024.367806897379;7027.578345299273;7004.5797252164775;7074.0450039244815;7079.115110611174;7080.64596770162;7097.396721278672;6949.722011119549;7023.051887995106;7034.6834392452465;7055.541389809646;7074.1511018677575;6937.930620693779;6955.304469553055;6960.79117626472;6994.0558024666525;7001.229864714877;31779.52330715041;31896.840515797274;31900.20249493758;32005.839970799996;32150.678493215004;3096.5819614352226;3169.6830316968117;3170.1916011416943;3179.6979286967703;3181.920451988719;24820.5035899281;24881;24935.376615584573;25014.624780628306;25046.87476562624;3395.2021275000357;3396.575428071491;3428.0058782953165;3428.879989200366;3453.4474484082675;128197.35901320526;128250;129728;131565.34217328948;131849.34075329563;35679.64320356815;35791.28417431689;35855.82072089675;35919.4612080819;35926.281474370364;38233.426498601984;38314;38332;38370.42444363337;38492.42261366082;11517.942410287895;11555.942220288845;11563.595274165364;11604.607447106402;11632.65102046923;9261.675841345655;9326.160645541799;9330;9356.298277629205;9373.671921482715;12234.08244381675;12278.815817762741;12289.893909548184;12313.07651926109;12342.382880855921;5323.387810401776;5385.676859388371;5392.784288628411;5395.2986111806;5400.648957817729;961.6297725375781;972.2416515118219;974.7124598243536;974.8635191073255;997.9251556133319;21104.89447552783;21406;21479.570408591742;21502.78497215008;21839.45401364947;1018.2261481274285;1035.425338936882;1058.523664351045;1059.3696750433635;1061.7611037516651;11379;11403.885961140282;11480.253783504046;11505.482253298622;11509.136814738928;168244;168613;168849;169334;169905;40537.79731101385;40868.182636347105;40871.59128408737;40947.59052409497;41115.794421027706;1297.1309222820732;1316.888064514527;1323.5963031275553;1326.0982531878221;1330.9534166304327;20385.59228815445;20498.282560110325;20749.89625051865;20956;21157;29620.111396658136;29671.554926675686;29671.851640741657;29716.10851674453;29716.55425168581;157558;157719;157771;158140;158261.2086939558;27644.723552764215;27813.721862781924;27883.16350509488;27992.58011129794;28017.859910700317;33958.66041339555;34212;34326.48510272298;34364.82817585896;34489.827550862086;26321;26727.22117484371;26987.325316867235;27078.864605676845;27101.322466938484;26174.86912565425;26208.606870897333;26556.8672156638;26780.732192677824;27257.169011562244;29438.558421624122;29704.405911882073;29723.405531889675;29725.405491890473;29771.70228297776;26015;26158.34604134912;26208.213753587424;26591.069312573967;27149.321266968484;21445.571088577828;21787.984355510016;22017.22939697103;22069.227577034726;22070.66893996559
18:59:43     INFO -  PID 2520 | |2;jquery.html;381.8663467786277;390.4280229463836;391.62208468827583;395.09917388354563;403.8546123395577;17228.415737639345;18575;18664.253429862823;18706.90646546767;18890.244390224376;16751.66496670066;16985.405510807122;17190.82809171911;17873.910630446862;17988.280468781264;5212.192110222912;5382.300300960889;5386.48828361305;5408.702521361323;5428.212909128174;5355.544778693797;5602.859928501779;5605.215269862222;5607.691576963265;5615.6630602164005;5515.558755299587;5530.364008139055;5532.502074813266;5548.167774833767;5550.750216240259;5360.785568577272;5470.234167216613;5478.01395748765;5494.2857428534435;5499.065158922993;4817.566419022305;4934.481879402647;4942.505749425065;4970.080535101018;4975.552200301954;21752.238671646417;22081.33755987323;22262.777372226396;22412.43968900774;22568.43578910524;1704.5653358393654;1755.1926113987581;1761.9383321583682;1769.1154422788607;1769.9646007079914;14029;14913;14960;15122.319495622613;15123.546293611209;2089.0599230346406;2111.788821117891;2113.4188098272944;2127.680847872816;2130.754963179223;78629;79318.20681793166;79934.600326998;81203;82472.9999999994;10517.894821051692;10722;10787.35709751116;10860.891391086147;10866.782664346669;14910.776338354934;14941.103533788008;14951.925240373947;14957.77563336529;14964.551063468114;6937.861242775116;7235.095613048369;7242.565446073252;7259.947307640363;7369.8894516582295;6582.63795491243;6622.602643841385;6655.401013908771;6678.365555272241;6691.899621505681;6887.483438742114;6964.547304425196;6988.825279367955;6989.33601307875;6998.125234345707;2012.5773587546487;2015.8689685170416;2016.133062782988;2019.5556977464935;2162.0378931375703;908.7682640926654;927.1007123090726;936.461534617584;946.6024269806697;953.3136141977765;17313;17518.562035949202;17565.912170439067;17757.378491752985;17889.01610411414;914.92680585553;917.5916717060977;918.5774543709969;927.2767241551601;936.6628013914985;9621.807563848684;9849.113579777855;9855.901440985499;9892.25808064398;9896.059874311928;340496;346517;349208;349885;351115;75154.24845751582;77510.22489775142;79211.60394197992;79242;82812;1012.129568571043;1026.9537870795682;1040.599369242832;1042.213129087534;1053.252190944438;14654.56036318912;14721;14743.262836858328;14989.700205996038;15063.397464101752;39254;40867.36530538745;41681.58318416777;42215.788921055195;43150.568494314655;49728.75135624299;49839.50160498349;50039.99920001652;50064.49935500598;51070;7937.563434010954;8269.173082691683;8292.215186080482;8460.873086903579;8506.06433292325;12064.819027714415;12478.313692746622;12694.365281736062;12708.555200567936;12739.363031848556;10939.28894621847;10948.34309941406;10968.23222374458;11020.779584408427;11168.106551476025;9903.207743380657;9944.005599439997;10112.544935477774;10175.694729158136;10181.236407269336;11179.944100279772;11194.552217911192;11274;11358.886411136113;11395.316281023164;8283.29591984688;8295.129011453952;8304.58477076156;8359.832803343777;8538.658453661785;10859.945700271448;10975.121990240921;11033.172512061466;11116.055135313589;11122
18:59:43     INFO -  PID 2520 | |3;mootools.html;1232.1682864066754;1285.832841730575;1286.7040580666446;1291.1220370148296;1297.5588299978008;8527.104654011324;8814.91185088149;8926.241269492093;8944.418612790172;9108.544572771352;8853.95573022134;8985.640574377017;9031.187193152615;9033.683821066264;9062.456252624846;2065.1120018392085;2102.358780571925;2107.4309936317186;2115.809577138057;2118.0998075817793;1997.8201961823434;2063.1953538120147;2071.2439959414783;2076.055394795372;2097.5595125023688;2001.7998200179939;2007.1770574064637;2015.4961259685078;2023.959520809583;2030.6750919852827;2001.719759233701;2007.056683358819;2009.4775358406773;2015.586804705032;2021.353166986565;1926.4413320137144;1986.860919735619;1991.7709463411747;2008.4476768888526;2017.1225516900195;8890.733278001606;8893.822123557493;8932.240759535447;8944.731658050268;8945.46327220369;4891.633127515451;5046.343975283226;5084.618653600995;5092.465291144414;5099.107656160194;2823.1248313022825;2913.3590610065753;2956.0836140796423;2978.166113488205;2981.5825784390204;1022.8619136416563;1052.4001319248032;1054.1882750282239;1063.186662203415;1066.5040756048397;12257.325847078408;12320.75358492825;12323.630291091282;12455.252684838848;12468.501259949591;4006.098627808778;4032.7177097602885;4150.937735933963;4177.665786737054;4242.554531774119;9532.094451027142;9594.04059594035;9594.568244429018;9604.27967902396;9609;4793.5685788279225;4831.9275210871865;4850.927236091461;4857.222844344888;4858.149823780895;4438.068005718836;4498.955010449919;4511.526289739596;4516.954830451719;4647.744374059392;3410.4031794435873;3410.84651190697;3446.2245994651503;3479.965200347964;3517.8416971236356;1038.2783965144151;1040.6045702633103;1049.9107575855985;1052.489542571852;1058.2803693488502;660.2275337854721;672.7746205021275;678.7963610916705;689.7068745783022;693.9861202775916;5043.924341134886;5045.495450454925;5060.410953459707;5107.361579802525;5152.742362881841;542.6635485998706;842.7808769719917;869.2263885142229;872.3675335381924;875.2472873328932;3467.289205712823;3481.7736847104857;3483.4600636901323;3520.0847779577493;3524.2070534129616;10771.461426928623;11065.834012489819;11225.326480411202;11248.606298779503;11314.603988860516;10845.728856778644;11150.776984460266;11366.318020918772;11427.314361138358;11438.656840294805;8221.260086592236;8286.627101780314;8363.749087527383;8505.787355316043;8507.787305317417;5635.323761148688;5732.971335143297;5753.280839895013;5785.566082543742;5953.880922381615;9944.30389872702;10014.098731114234;10017.54921028541;10044.497775111362;10089.495525223856;10280.794384112425;10335.328203666737;10353.792924141324;10378.740531486774;10389.480525973822;7528.096628404407;7619.619019049136;7659.770206893802;7687.500312479671;7710.730124445618;8325.375596830383;8432.915670843213;8470.449420787629;8470.618822153141;8507.489550626982;7191;7213.819654508679;7255.274472552703;7319.194888562148;7335;7131.644987452368;7204.207537170802;7243.855122897618;7296.379807716404;7321.084864391951;6594.538382313192;6622.63575503352;6654.268030516542;6655.733770649314;6669.09967154428;4642.582167604932;4780.330753694555;4782.258749893772;4799.424069111589;4801.615870730403;4751.857444276678;4817.421909370758;4825.638077144298;4836.274558816065;4979.526944940225
18:59:43     INFO -  PID 2520 | |4;prototype.html;356.3052048505415;367.7168580193251;371.1222957705028;371.20932413958263;376.6722951032602;5092.923606145901;5282.498162674549;5403.297571315728;5427.240186373906;5456.91814622781;5151.227315902616;5259.76331065102;5299.867503312419;5321.654092483986;5339.813106541272;4206.579342065799;4219;4232.407462955189;4236.661067114639;4238.237117318881;4080.7143499955014;4206.894827629303;4225.323948168294;4232.195882782262;4246.7451952882775;4153.771542565158;4161.812718427663;4166.250074986501;4190.371444283367;4197.16056788642;4169.291220492523;4170.72890262132;4178.143480586503;4178.937315940263;4181.874543763677;3773.52830896138;3777;3779.1496913194587;3781.716371272138;3791.9193029986322;5163.32876726027;5201.817936372209;5226.712530810804;5226.973865130688;5230.529252367267;4815.686980346301;4831.782569784368;4836.540528649773;4836.782344794493;4838.42751105892;5476.835694929158;5519.558435325164;5548.4174161712845;5598.776048958037;5602.38373778884;3999.5400528939253;4004.6796256299426;4015.6988225883174;4071.9592804071876;4103.261412945699;5542.944570554283;5753.957345142498;5764.625299355571;5772.451617096411;5843.795467158671;3922.117523557177;3938.2517321708783;3941.4481972523868;3948.072203032285;3961.900952476211;3968.5634580196156;3978.462907507507;3988.720789544704;3992.8802135935966;3996.140829721624;4491.236489796743;4537.183307004705;4559.794809233593;4577.130345234395;4591.265397536378;5477.4248703886315;5504.972475137679;5505.119180931032;5512.200730893998;5520.3651580068;1359.0826192320144;1362.557168920105;1362.6661467940219;1373.1462525590373;1375.848656647768;883.1830556734994;912.7489940266347;917.3257655623112;929.8930622978309;942.1426501883253;5292.92060619091;5294.179402192666;5307.28351672527;5307.363116426053;5359.437259087817;5779.190913272061;5784.82645520635;5790.42095790426;5793.246877905845;5836.665333866403;5107.361579802525;5230.215467679878;5275.57795376369;5275.947240527622;5286.330403146387;3041.9353226370595;3045.3909218156014;3061.8009829361467;3076.3078307381106;3076.676948920331;5749.798757043483;5869;5881;5897.705114744245;5912.46787789101;5702.116171993348;5804.303483581997;5830.679312637761;5844.59087863854;5860.3260625027815;5848.210491583667;5878.383444552696;5888.558358123072;5905.379935106838;5924.045065128497;5564.137558678412;5683.403242659461;5730.169125476866;5777.7977770777825;5777.7977770777825;5530.962397449965;5577.442255774552;5612.7754889803955;5613.578981576316;5646;5685.943140568541;5786.218860453953;5830.883382332245;5869.4717475427415;5874.530037597067;3894.1432884765304;3895.422353946656;3903.8828835133854;3912.8630497932436;3928.9569423899984;5792.391798861059;5804.390538993345;5849.94150058494;5862.237909071793;5864.32560255576;5329.227262047059;5592.720363981866;5596.496315331639;5604.299462567179;5625.734209802762;5626.1842032905815;5633.408492108433;5634.126710359901;5634.915476267777;5643.435656434323;5251.949610077923;5500.50495455411;5521.1442226454965;5536.7231638418725;5548.1691041955255;5644.491995720405;5659;5660.830175094754;5664.150377443417;5675.4040825714355;5553.666779993213;5570.387257401763;5576.414476480073;5578.330600327824;5586.972065139648
18:59:43     INFO -  PID 2520 | |5;yui.html;787.2993036197781;794.3962588432792;810.5420437452839;815.8409110223505;816.4366587054932;13620.931895340522;13907.860921390784;14270.072445291062;14271.143731376113;14763.261836908165;14907.552773416788;15046.24768761563;15773.447929322476;15987;16015.919920400382;896.4307664632939;900.8873890763655;906.2976193450063;906.5331354352513;908.4867050116696;872.7774417523523;903.8418276801533;911.8541033434618;911.8632205169245;914.4878867834001;964.2719746591314;964.9614015439374;965.8985806490323;965.9178969787577;966.3622009473748;952.523738130938;953.046953046953;954.5847556312957;958.1281034258826;961.3366776923936;709.5423451873564;711.697528550364;712.9857402851966;713.425692317684;715.5420530860254;13419.396127174203;13500.392482338319;13910.234937078456;13911.095778774346;14018.719625607533;15164.772528412082;15317;15495.070295782176;15578.298976546082;15678.451254206047;12077;12233.143679942408;12270.202436841666;12324.383780811013;12341.259524428562;3194.5847039884898;3233.9353212935844;3241.594800649919;3246.091094493522;3246.772725909187;61690.074648880305;62181.99999999955;62610.37389626091;62827.685861570855;63296;10648;10716.785664286826;10840.457977101114;10962.780744385067;11013.063889569476;19373.32193373225;19658.70511942322;19687.40937771869;19953.301634442723;19958;7678.462507624525;7947.9205207948335;7998.240167184108;7998.360131189607;8006.278650090258;3921.4117882317883;3929.7642141471033;3961.3265744823448;3985.621365970228;4000.6399424051974;3247.1437161755694;3287.7369810415107;3369.22507823202;3389.000244927703;3406.42090844557;643.7264162730821;651.1177354684335;652.1717418878093;656.4846595422666;663.4427081251772;624.1792043462832;639.1882309466951;644.223710428932;648.5816648261939;664.5016237821634;8634.568271586395;8912.420692654956;9117.498537580364;9159.633614655339;9738.805223895482;610.9938900611025;628.0924064726427;633.66732465456;640.1613885809604;655.5968079630993;4211.684123690736;4323.351497275434;4351.978240108842;4394.209042372339;4404.537523560044;55531.44468555343;55963;56228.43771562232;56586;56805.147922781194;48535;49543.50456495461;49671;50369;51088.489115109114;44943;45783.313250301275;46152;46183.80840141446;46459.30311045337;8476.406651534333;8587.398882078194;8618.913810861812;8627.35294852876;8651.048384677806;22965.770342296364;23435.648465273374;23627.881860590587;24060.639090413308;24109.276721698378;28796.568051479662;28900.710992889803;28939.42121157607;29258.414831703674;29531.40937181287;10692.57229710834;10812.513436895515;10902.618408355669;12823.743525129632;13346.265955372548;13973.650658733613;14197.716045678822;14232.644183895485;14415.981762553041;14426.927865360605;13442.865571344162;13488.595342139752;13554.322283885569;13637.249951252776;13805.861941380457;13186.80219796723;13265.938724901791;13496.460141594227;13501.932490337485;13520;13035;13074.54239101665;13283.933580332423;13413.86586134126;13514.121582097132;9609.039096090335;9741.756456088655;9744.951275243578;9880.555375008285;10098.747531311776;10492.422916739653;10744.677659670222;11252.26860254081;11355.943220283845;11413.885861141282
18:59:43     INFO -  PID 2520 | __end_tp_report
18:59:43     INFO -  PID 2520 | __start_cc_report
18:59:43     INFO -  PID 2520 | _x_x_mozilla_cycle_collect,354
18:59:43     INFO -  PID 2520 | __end_cc_report
18:59:43     INFO -  PID 2520 | __startTimestamp1492135183161__endTimestamp
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | ------- Summary: start -------
18:59:43     INFO -  PID 2520 | Number of tests: 6
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | [#0] dojo.html  Cycles:165  Average:4964.62  Median:5200.82  stddev:625.48 (12.0%)  stddev-sans-first:605.83
18:59:43     INFO -  PID 2520 | Values: 2889.1  2898.7  2916.4  2939.7  2945.3  5070.3  5076.3  5085.7  5101.1  5110.3  5012.5  5089.4  5089.5  5121.0  5139.0  4606.4  4609.2  4657.5  4671.8  4705.6  4636.3  4643.0  4668.1  4677.9  4722.4  4613.4  4651.9  4656.0  4661.2  4706.9  4462.4  4492.7  4513.2  4538.6  4615.7  4554.2  4573.5  4581.4  4590.8  4592.8  4907.9  4952.2  5008.5  5033.6  5038.7  5256.7  5324.3  5361.0  5384.5  5406.4  5353.7  5413.9  5422.4  5442.5  5467.3  4921.4  4959.9  4979.6  5008.3  5014.8  5442.8  5448.0  5506.3  5518.0  5548.8  5243.0  5263.1  5302.7  5350.7  5355.4  5298.5  5359.4  5393.6  5419.3  5426.8  5314.9  5322.0  5332.3  5387.1  5387.2  5111.3  5125.0  5238.2  5246.7  5251.8  3506.5  3515.1  3519.0  3530.7  3558.9  3279.2  3286.2  3297.1  3308.6  3317.2  4998.5  5009.8  5015.8  5032.8  5070.7  5297.7  5316.6  5372.2  5373.2  5396.7  4966.9  4974.9  4983.1  4986.2  5006.4  4470.6  4471.8  4506.8  4515.4  4552.6  5511.3  5512.4  5517.9  5525.2  5551.4  5376.8  5434.8  5456.7  5475.3  5496.8  5378.2  5424.1  5429.3  5434.4  5437.8  5200.8  5370.8  5381.2  5408.2  5432.6  5439.0  5447.3  5460.1  5460.5  5467.9  5197.0  5291.4  5301.6  5303.7  5364.4  5207.3  5262.9  5277.8  5322.9  5337.9  5180.2  5207.3  5214.4  5230.6  5260.8  5105.9  5298.3  5317.5  5323.4  5343.3  5147.1  5199.7  5268.2  5290.1  5303.1
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | [#1] ext.html  Cycles:180  Average:29241.20  Median:29748.55  stddev:39421.73 (132.5%)  stddev-sans-first:39474.00
18:59:43     INFO -  PID 2520 | Values: 684.9  726.4  752.7  1026.9  1054.3  30104.7  30872.4  30874.4  30905.7  31074.2  31733.5  31882.8  32049.5  32117.4  32150.2  6739.4  6832.7  6911.7  6922.8  6975.9  6948.3  6997.9  7016.3  7024.4  7027.6  7004.6  7074.0  7079.1  7080.6  7097.4  6949.7  7023.1  7034.7  7055.5  7074.2  6937.9  6955.3  6960.8  6994.1  7001.2  31779.5  31896.8  31900.2  32005.8  32150.7  3096.6  3169.7  3170.2  3179.7  3181.9  24820.5  24881.0  24935.4  25014.6  25046.9  3395.2  3396.6  3428.0  3428.9  3453.4  128197.4  128250.0  129728.0  131565.3  131849.3  35679.6  35791.3  35855.8  35919.5  35926.3  38233.4  38314.0  38332.0  38370.4  38492.4  11517.9  11555.9  11563.6  11604.6  11632.7  9261.7  9326.2  9330.0  9356.3  9373.7  12234.1  12278.8  12289.9  12313.1  12342.4  5323.4  5385.7  5392.8  5395.3  5400.6  961.6  972.2  974.7  974.9  997.9  21104.9  21406.0  21479.6  21502.8  21839.5  1018.2  1035.4  1058.5  1059.4  1061.8  11379.0  11403.9  11480.3  11505.5  11509.1  168244.0  168613.0  168849.0  169334.0  169905.0  40537.8  40868.2  40871.6  40947.6  41115.8  1297.1  1316.9  1323.6  1326.1  1331.0  20385.6  20498.3  20749.9  20956.0  21157.0  29620.1  29671.6  29671.9  29716.1  29716.6  157558.0  157719.0  157771.0  158140.0  158261.2  27644.7  27813.7  27883.2  27992.6  28017.9  33958.7  34212.0  34326.5  34364.8  34489.8  26321.0  26727.2  26987.3  27078.9  27101.3  26174.9  26208.6  26556.9  26780.7  27257.2  29438.6  29704.4  29723.4  29725.4  29771.7  26015.0  26158.3  26208.2  26591.1  27149.3  21445.6  21788.0  22017.2  22069.2  22070.7
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | [#2] jquery.html  Cycles:180  Average:24120.17  Median:19822.81  stddev:57914.83 (292.2%)  stddev-sans-first:58049.88
18:59:43     INFO -  PID 2520 | Values: 381.9  390.4  391.6  395.1  403.9  17228.4  18575.0  18664.3  18706.9  18890.2  16751.7  16985.4  17190.8  17873.9  17988.3  5212.2  5382.3  5386.5  5408.7  5428.2  5355.5  5602.9  5605.2  5607.7  5615.7  5515.6  5530.4  5532.5  5548.2  5550.8  5360.8  5470.2  5478.0  5494.3  5499.1  4817.6  4934.5  4942.5  4970.1  4975.6  21752.2  22081.3  22262.8  22412.4  22568.4  1704.6  1755.2  1761.9  1769.1  1770.0  14029.0  14913.0  14960.0  15122.3  15123.5  2089.1  2111.8  2113.4  2127.7  2130.8  78629.0  79318.2  79934.6  81203.0  82473.0  10517.9  10722.0  10787.4  10860.9  10866.8  14910.8  14941.1  14951.9  14957.8  14964.6  6937.9  7235.1  7242.6  7259.9  7369.9  6582.6  6622.6  6655.4  6678.4  6691.9  6887.5  6964.5  6988.8  6989.3  6998.1  2012.6  2015.9  2016.1  2019.6  2162.0  908.8  927.1  936.5  946.6  953.3  17313.0  17518.6  17565.9  17757.4  17889.0  914.9  917.6  918.6  927.3  936.7  9621.8  9849.1  9855.9  9892.3  9896.1  340496.0  346517.0  349208.0  349885.0  351115.0  75154.2  77510.2  79211.6  79242.0  82812.0  1012.1  1027.0  1040.6  1042.2  1053.3  14654.6  14721.0  14743.3  14989.7  15063.4  39254.0  40867.4  41681.6  42215.8  43150.6  49728.8  49839.5  50040.0  50064.5  51070.0  7937.6  8269.2  8292.2  8460.9  8506.1  12064.8  12478.3  12694.4  12708.6  12739.4  10939.3  10948.3  10968.2  11020.8  11168.1  9903.2  9944.0  10112.5  10175.7  10181.2  11179.9  11194.6  11274.0  11358.9  11395.3  8283.3  8295.1  8304.6  8359.8  8538.7  10859.9  10975.1  11033.2  11116.1  11122.0
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | [#3] mootools.html  Cycles:180  Average:5582.47  Median:4766.09  stddev:3420.81 (71.8%)  stddev-sans-first:3414.79
18:59:43     INFO -  PID 2520 | Values: 1232.2  1285.8  1286.7  1291.1  1297.6  8527.1  8814.9  8926.2  8944.4  9108.5  8854.0  8985.6  9031.2  9033.7  9062.5  2065.1  2102.4  2107.4  2115.8  2118.1  1997.8  2063.2  2071.2  2076.1  2097.6  2001.8  2007.2  2015.5  2024.0  2030.7  2001.7  2007.1  2009.5  2015.6  2021.4  1926.4  1986.9  1991.8  2008.4  2017.1  8890.7  8893.8  8932.2  8944.7  8945.5  4891.6  5046.3  5084.6  5092.5  5099.1  2823.1  2913.4  2956.1  2978.2  2981.6  1022.9  1052.4  1054.2  1063.2  1066.5  12257.3  12320.8  12323.6  12455.3  12468.5  4006.1  4032.7  4150.9  4177.7  4242.6  9532.1  9594.0  9594.6  9604.3  9609.0  4793.6  4831.9  4850.9  4857.2  4858.1  4438.1  4499.0  4511.5  4517.0  4647.7  3410.4  3410.8  3446.2  3480.0  3517.8  1038.3  1040.6  1049.9  1052.5  1058.3  660.2  672.8  678.8  689.7  694.0  5043.9  5045.5  5060.4  5107.4  5152.7  542.7  842.8  869.2  872.4  875.2  3467.3  3481.8  3483.5  3520.1  3524.2  10771.5  11065.8  11225.3  11248.6  11314.6  10845.7  11150.8  11366.3  11427.3  11438.7  8221.3  8286.6  8363.7  8505.8  8507.8  5635.3  5733.0  5753.3  5785.6  5953.9  9944.3  10014.1  10017.5  10044.5  10089.5  10280.8  10335.3  10353.8  10378.7  10389.5  7528.1  7619.6  7659.8  7687.5  7710.7  8325.4  8432.9  8470.4  8470.6  8507.5  7191.0  7213.8  7255.3  7319.2  7335.0  7131.6  7204.2  7243.9  7296.4  7321.1  6594.5  6622.6  6654.3  6655.7  6669.1  4642.6  4780.3  4782.3  4799.4  4801.6  4751.9  4817.4  4825.6  4836.3  4979.5
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | [#4] prototype.html  Cycles:180  Average:4690.84  Median:5325.44  stddev:1383.50 (26.0%)  stddev-sans-first:1348.58
18:59:43     INFO -  PID 2520 | Values: 356.3  367.7  371.1  371.2  376.7  5092.9  5282.5  5403.3  5427.2  5456.9  5151.2  5259.8  5299.9  5321.7  5339.8  4206.6  4219.0  4232.4  4236.7  4238.2  4080.7  4206.9  4225.3  4232.2  4246.7  4153.8  4161.8  4166.3  4190.4  4197.2  4169.3  4170.7  4178.1  4178.9  4181.9  3773.5  3777.0  3779.1  3781.7  3791.9  5163.3  5201.8  5226.7  5227.0  5230.5  4815.7  4831.8  4836.5  4836.8  4838.4  5476.8  5519.6  5548.4  5598.8  5602.4  3999.5  4004.7  4015.7  4072.0  4103.3  5542.9  5754.0  5764.6  5772.5  5843.8  3922.1  3938.3  3941.4  3948.1  3961.9  3968.6  3978.5  3988.7  3992.9  3996.1  4491.2  4537.2  4559.8  4577.1  4591.3  5477.4  5505.0  5505.1  5512.2  5520.4  1359.1  1362.6  1362.7  1373.1  1375.8  883.2  912.7  917.3  929.9  942.1  5292.9  5294.2  5307.3  5307.4  5359.4  5779.2  5784.8  5790.4  5793.2  5836.7  5107.4  5230.2  5275.6  5275.9  5286.3  3041.9  3045.4  3061.8  3076.3  3076.7  5749.8  5869.0  5881.0  5897.7  5912.5  5702.1  5804.3  5830.7  5844.6  5860.3  5848.2  5878.4  5888.6  5905.4  5924.0  5564.1  5683.4  5730.2  5777.8  5777.8  5531.0  5577.4  5612.8  5613.6  5646.0  5685.9  5786.2  5830.9  5869.5  5874.5  3894.1  3895.4  3903.9  3912.9  3929.0  5792.4  5804.4  5849.9  5862.2  5864.3  5329.2  5592.7  5596.5  5604.3  5625.7  5626.2  5633.4  5634.1  5634.9  5643.4  5251.9  5500.5  5521.1  5536.7  5548.2  5644.5  5659.0  5660.8  5664.2  5675.4  5553.7  5570.4  5576.4  5578.3  5587.0
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | [#5] yui.html  Cycles:180  Average:13991.41  Median:4106.16  stddev:15793.51 (384.6%)  stddev-sans-first:15806.69
18:59:43     INFO -  PID 2520 | Values: 787.3  794.4  810.5  815.8  816.4  13620.9  13907.9  14270.1  14271.1  14763.3  14907.6  15046.2  15773.4  15987.0  16015.9  896.4  900.9  906.3  906.5  908.5  872.8  903.8  911.9  911.9  914.5  964.3  965.0  965.9  965.9  966.4  952.5  953.0  954.6  958.1  961.3  709.5  711.7  713.0  713.4  715.5  13419.4  13500.4  13910.2  13911.1  14018.7  15164.8  15317.0  15495.1  15578.3  15678.5  12077.0  12233.1  12270.2  12324.4  12341.3  3194.6  3233.9  3241.6  3246.1  3246.8  61690.1  62182.0  62610.4  62827.7  63296.0  10648.0  10716.8  10840.5  10962.8  11013.1  19373.3  19658.7  19687.4  19953.3  19958.0  7678.5  7947.9  7998.2  7998.4  8006.3  3921.4  3929.8  3961.3  3985.6  4000.6  3247.1  3287.7  3369.2  3389.0  3406.4  643.7  651.1  652.2  656.5  663.4  624.2  639.2  644.2  648.6  664.5  8634.6  8912.4  9117.5  9159.6  9738.8  611.0  628.1  633.7  640.2  655.6  4211.7  4323.4  4352.0  4394.2  4404.5  55531.4  55963.0  56228.4  56586.0  56805.1  48535.0  49543.5  49671.0  50369.0  51088.5  44943.0  45783.3  46152.0  46183.8  46459.3  8476.4  8587.4  8618.9  8627.4  8651.0  22965.8  23435.6  23627.9  24060.6  24109.3  28796.6  28900.7  28939.4  29258.4  29531.4  10692.6  10812.5  10902.6  12823.7  13346.3  13973.7  14197.7  14232.6  14416.0  14426.9  13442.9  13488.6  13554.3  13637.2  13805.9  13186.8  13265.9  13496.5  13501.9  13520.0  13035.0  13074.5  13283.9  13413.9  13514.1  9609.0  9741.8  9745.0  9880.6  10098.7  10492.4  10744.7  11252.3  11355.9  11413.9
18:59:43     INFO -  PID 2520 | -------- Summary: end --------
18:59:43     INFO -  PID 2520 |
18:59:43     INFO -  PID 2520 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:59:43     INFO -  PID 2520 | [GPU 1352] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:59:43     INFO -  PID 2520 | [GPU 1352] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:59:43     INFO -  PID 2520 | [GPU 1352] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:59:43     INFO -  PID 2520 | [Child 2992] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:59:43     INFO -  PID 2520 | [Child 2992] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:59:43     INFO -  PID 2520 | Unable to read VR Path Registry from C:\Users\cltbld.T-W864-IX-031\AppData\Local\openvr\openvrpaths.vrpath
18:59:43     INFO -  TEST-INFO | 2520: exit 0
18:59:43     INFO -  mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip
18:59:48     INFO -  mozcrash Copy/paste: C:\slave\test\build\win32-minidump_stackwalk.exe c:\users\cltbld~1.t-w\appdata\local\temp\tmp2cjdkj\profile\minidumps\a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp c:\users\cltbld~1.t-w\appdata\local\temp\tmphevfrr
18:59:48     INFO -  mozcrash Saved minidump as C:\slave\test\build\blobber_upload_dir\a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp
18:59:49     INFO -  PROCESS-CRASH | dromaeo_css | application crashed [unknown top frame]
18:59:49     INFO -  Crash dump filename: c:\users\cltbld~1.t-w\appdata\local\temp\tmp2cjdkj\profile\minidumps\a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp
18:59:49     INFO -  stderr from minidump_stackwalk:
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4359: INFO: Minidump opened minidump c:\users\cltbld~1.t-w\appdata\local\temp\tmp2cjdkj\profile\minidumps\a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4479: INFO: Minidump not byte-swapping minidump
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 15 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 7 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 7 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 1197932545 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 6 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 1197932546 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 4 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 5 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4956: INFO: GetStream: type 3 not present
18:59:49     INFO -  2017-04-13 18:59:48: minidump_processor.cc:152: ERROR: Minidump c:\users\cltbld~1.t-w\appdata\local\temp\tmp2cjdkj\profile\minidumps\a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp has no thread list
18:59:49     INFO -  2017-04-13 18:59:48: stackwalk.cc:139: ERROR: MinidumpProcessor::Process failed
18:59:49     INFO -  2017-04-13 18:59:48: minidump.cc:4331: INFO: Minidump closing minidump
18:59:49     INFO -  minidump_stackwalk exited with return code 1
18:59:49     INFO -  TEST-UNEXPECTED-ERROR | dromaeo_css | Found crashes after test run, terminating test
18:59:49    ERROR -  Traceback (most recent call last):
18:59:49     INFO -    File "C:\slave\test\build\tests\talos\talos\run_tests.py", line 202, in run_tests
18:59:49     INFO -      talos_results.add(mytest.runTest(browser_config, test))
18:59:49     INFO -    File "C:\slave\test\build\tests\talos\talos\ttest.py", line 70, in runTest
18:59:49     INFO -      return self._runTest(browser_config, test_config, setup)
18:59:49     INFO -    File "C:\slave\test\build\tests\talos\talos\ttest.py", line 243, in _runTest
18:59:49     INFO -      test_config['name'])
18:59:49     INFO -    File "C:\slave\test\build\tests\talos\talos\ttest.py", line 47, in check_for_crashes
18:59:49     INFO -      raise TalosCrash("Found crashes after test run, terminating test")
18:59:49     INFO -  TalosCrash: Found crashes after test run, terminating test
18:59:49     INFO -  TEST-INFO took 1125557ms
18:59:49     INFO -  SUITE-END | took 1125s
18:59:49    ERROR - Return code: 2
18:59:49  WARNING - setting return code to 2
18:59:49    ERROR - # TBPL FAILURE #
18:59:49     INFO - Running post-action listener: _resource_record_post_action
18:59:49     INFO - [mozharness: 2017-04-14 01:59:49.583000Z] Finished run-tests step (success)
18:59:49     INFO - Running post-run listener: _resource_record_post_run
18:59:49     INFO - Total resource usage - Wall time: 1128s; CPU: 14.0%; Read bytes: 125590528; Write bytes: 267210240; Read time: 1964410; Write time: 2802730
18:59:49     INFO - TinderboxPrint: CPU usage<br/>13.7%
18:59:49     INFO - TinderboxPrint: I/O read bytes / time<br/>125,590,528 / 1,964,410
18:59:49     INFO - TinderboxPrint: I/O write bytes / time<br/>267,210,240 / 2,802,730
18:59:49     INFO - TinderboxPrint: CPU idle<br/>7,790.0 (86.3%)
18:59:49     INFO - TinderboxPrint: CPU user<br/>1,192.0 (13.2%)
18:59:49     INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 1082368; Read time: 0; Write time: 4600
18:59:49     INFO - run-tests - Wall time: 1127s; CPU: 14.0%; Read bytes: 125590528; Write bytes: 207044608; Read time: 1964410; Write time: 2733880
18:59:50     INFO - Running post-run listener: _upload_blobber_files
18:59:50     INFO - Blob upload gear active.
18:59:50     INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
18:59:50     INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with <Firefox-Non-PGO> branch at the following location(s): https://blobupload.elasticbeanstalk.com
18:59:50     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Firefox-Non-PGO', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
18:59:50     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Firefox-Non-PGO -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
18:59:50     INFO -  (blobuploader) - INFO - Open directory for files ...
18:59:50     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp ...
18:59:50     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
18:59:50     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
18:59:51     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a6132d793a390d0451f571a1a0bf3f173380d30af2a2e266fecacae01a9a00f99e646ca9e3c87493fc7039c81d1b0ca98d35ec2c7112cb05d778d8740564482'>a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp</a>: uploaded
18:59:51     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
18:59:51     INFO -  (blobuploader) - INFO - Done attempting.
18:59:51     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log ...
18:59:51     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
18:59:51     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
18:59:52     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0627a8a3b214c411497f18289ebedbbe11761afc8fe888c83246596edac354afe5263065bd5c1e0f7c24e5b9e8f2b2f22804de2261e5919f19c80a95281a61'>dromaeojs-e10s_errorsummary.log</a>: uploaded
18:59:52     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
18:59:52     INFO -  (blobuploader) - INFO - Done attempting.
18:59:52     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log ...
18:59:52     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
18:59:52     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
18:59:53     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77ddfc2bac682dfda7a4f687e3ae55006fff52a4589e2d3f6a454fc8311dcc6bc9ae8af730403a168addea4c2280f50af212066bb22f990ae237a9878f81fb91'>dromaeojs-e10s_raw.log</a>: uploaded
18:59:53     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
18:59:53     INFO -  (blobuploader) - INFO - Done attempting.
18:59:53     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
18:59:53     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
18:59:53     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
18:59:55     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06917fa946ae737b75b8454811ae1c9d65f4d1703e7687627fb6d80628fb85b48abb3f95eb8abbd1797ed3dba8a31cd61fc19d065d5c6c12538748f2ade6a9da'>resource-usage.json</a>: uploaded
18:59:55     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
18:59:55     INFO -  (blobuploader) - INFO - Done attempting.
18:59:55     INFO -  (blobuploader) - INFO - Iteration through files over.
18:59:55     INFO - Return code: 0
18:59:55     INFO - rmtree: C:\slave\test\build\uploaded_files.json
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
18:59:55     INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0627a8a3b214c411497f18289ebedbbe11761afc8fe888c83246596edac354afe5263065bd5c1e0f7c24e5b9e8f2b2f22804de2261e5919f19c80a95281a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06917fa946ae737b75b8454811ae1c9d65f4d1703e7687627fb6d80628fb85b48abb3f95eb8abbd1797ed3dba8a31cd61fc19d065d5c6c12538748f2ade6a9da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77ddfc2bac682dfda7a4f687e3ae55006fff52a4589e2d3f6a454fc8311dcc6bc9ae8af730403a168addea4c2280f50af212066bb22f990ae237a9878f81fb91", "a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a6132d793a390d0451f571a1a0bf3f173380d30af2a2e266fecacae01a9a00f99e646ca9e3c87493fc7039c81d1b0ca98d35ec2c7112cb05d778d8740564482"}
18:59:55     INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
18:59:55     INFO - Writing to file C:\slave\test\properties\blobber_files
18:59:55     INFO - Contents:
18:59:55     INFO -  blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0627a8a3b214c411497f18289ebedbbe11761afc8fe888c83246596edac354afe5263065bd5c1e0f7c24e5b9e8f2b2f22804de2261e5919f19c80a95281a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06917fa946ae737b75b8454811ae1c9d65f4d1703e7687627fb6d80628fb85b48abb3f95eb8abbd1797ed3dba8a31cd61fc19d065d5c6c12538748f2ade6a9da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77ddfc2bac682dfda7a4f687e3ae55006fff52a4589e2d3f6a454fc8311dcc6bc9ae8af730403a168addea4c2280f50af212066bb22f990ae237a9878f81fb91", "a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a6132d793a390d0451f571a1a0bf3f173380d30af2a2e266fecacae01a9a00f99e646ca9e3c87493fc7039c81d1b0ca98d35ec2c7112cb05d778d8740564482"}
18:59:55     INFO - Running post-run listener: copy_logs_to_upload_dir
18:59:55     INFO - Copying logs to upload dir...
18:59:55     INFO - mkdir: C:\slave\test\build\upload\logs
18:59:55     INFO - Copying logs to upload dir...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55     INFO - Using _rmtree_windows ...
18:59:55  WARNING - returning nonzero exit status 2
program finished with exit code 2
elapsedTime=1534.340000
========= master_lag: 0.21 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 25 mins, 34 secs) (at 2017-04-13 18:59:55.925418) =========

========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 18:59:55.926248) =========
'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f'
 in dir C:\slave\test\properties (timeout 1200 secs)
 watching logfiles {}
 argv: ['cmd', '/C', 'for', '%f', 'in', '(*)', 'do', '@type', '%f']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=T-W864-IX-031
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld.T-W864-IX-031
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Local
  LOGONSERVER=\\T-W864-IX-031
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg;
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_ARCHITEW6432=AMD64
  PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files (x86)
  PROGRAMFILES(X86)=C:\Program Files (x86)
  PROGRAMW6432=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test\properties
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  USERDOMAIN=T-W864-IX-031
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-031
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-031
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0627a8a3b214c411497f18289ebedbbe11761afc8fe888c83246596edac354afe5263065bd5c1e0f7c24e5b9e8f2b2f22804de2261e5919f19c80a95281a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06917fa946ae737b75b8454811ae1c9d65f4d1703e7687627fb6d80628fb85b48abb3f95eb8abbd1797ed3dba8a31cd61fc19d065d5c6c12538748f2ade6a9da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77ddfc2bac682dfda7a4f687e3ae55006fff52a4589e2d3f6a454fc8311dcc6bc9ae8af730403a168addea4c2280f50af212066bb22f990ae237a9878f81fb91", "a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a6132d793a390d0451f571a1a0bf3f173380d30af2a2e266fecacae01a9a00f99e646ca9e3c87493fc7039c81d1b0ca98d35ec2c7112cb05d778d8740564482"}
build_url:https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/QNdHYH4QRxqXdwuqUL3vdg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0627a8a3b214c411497f18289ebedbbe11761afc8fe888c83246596edac354afe5263065bd5c1e0f7c24e5b9e8f2b2f22804de2261e5919f19c80a95281a61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06917fa946ae737b75b8454811ae1c9d65f4d1703e7687627fb6d80628fb85b48abb3f95eb8abbd1797ed3dba8a31cd61fc19d065d5c6c12538748f2ade6a9da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77ddfc2bac682dfda7a4f687e3ae55006fff52a4589e2d3f6a454fc8311dcc6bc9ae8af730403a168addea4c2280f50af212066bb22f990ae237a9878f81fb91", "a4ce516c-2ed9-4a76-9a97-f6ebc3c9d1fb.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a6132d793a390d0451f571a1a0bf3f173380d30af2a2e266fecacae01a9a00f99e646ca9e3c87493fc7039c81d1b0ca98d35ec2c7112cb05d778d8740564482"}'
========= master_lag: 0.03 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 18:59:56.057992) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 18:59:56.058410) =========
'rm' '-f' 'oauth.txt'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-f', 'oauth.txt']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
  COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
  COMMONPROGRAMW6432=C:\Program Files\Common Files
  COMPUTERNAME=T-W864-IX-031
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld.T-W864-IX-031
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-031\AppData\Local
  LOGONSERVER=\\T-W864-IX-031
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_NO_REMOTE=1
  NO_EM_RESTART=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg;
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_ARCHITEW6432=AMD64
  PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files (x86)
  PROGRAMFILES(X86)=C:\Program Files (x86)
  PROGRAMW6432=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
  USERDOMAIN=T-W864-IX-031
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-031
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-031
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.03 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 18:59:56.187731) =========

========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-04-13 18:59:56.188166) =========

========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-04-13 18:59:57.164606) =========

========= Total master_lag: 0.60 =========