builder: mozilla-central_win8_64_test-dromaeojs-e10s
slave: t-w864-ix-084
starttime: 1490653257.87
results: failure (2)
buildid: 20170327142223
builduid: 0806d6fb823c4450be886428cd087542
revision: a6f35285bd1e674553527873614c55e0b7366bdb

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 15:20:57.869468) =========
master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 15:20:57.869895) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 15:20:57.870173) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 15:20:57.975835) =========

========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 15:20:57.976278) =========
'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-084\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-084
  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-084
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local
  LOGONSERVER=\\T-W864-IX-084
  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-084
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-084
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
--15:20:58--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
           => `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|: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%    8.92 MB/s

15:20:58 (8.92 MB/s) - `archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=1.413000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 15:20:59.452832) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2017-03-27 15:20:59.453182) =========
'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-084\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-084
  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-084
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local
  LOGONSERVER=\\T-W864-IX-084
  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-084
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-084
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
program finished with exit code 0
elapsedTime=4.316000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2017-03-27 15:21:03.787159) =========

========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 15:21:03.787637) =========
'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev a6f35285bd1e674553527873614c55e0b7366bdb --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 a6f35285bd1e674553527873614c55e0b7366bdb --destination scripts --debug']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld.T-W864-IX-084\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-084
  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-084
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local
  LOGONSERVER=\\T-W864-IX-084
  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-084
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-084
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
2017-03-27 15:21:03,509 truncating revision to first 12 chars
2017-03-27 15:21:03,509 Setting DEBUG logging.
2017-03-27 15:21:03,509 attempt 1/10
2017-03-27 15:21:03,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6f35285bd1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-03-27 15:21:03,930 unpacking tar archive at: mozilla-central-a6f35285bd1e/testing/mozharness/
2017-03-27 15:21:04,055 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.110000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 15:21:04.958149) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 15:21:04.958580) =========
script_repo_revision: a6f35285bd1e674553527873614c55e0b7366bdb
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 15:21:04.959018) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 15:21:04.959307) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 15:21:04.983631) =========

========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 23 mins, 12 secs) (at 2017-03-27 15:21:04.984000) =========
'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-084\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-084
  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-084
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local
  LOGONSERVER=\\T-W864-IX-084
  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-084
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-084
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
15:21:04     INFO - MultiFileLogger online at 20170327 15:21:04 in C:\slave\test
15:21:04     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
15:21:04     INFO - Dumping config to C:\slave\test\logs\localconfig.json.
15:21:04     INFO - {'append_to_log': False,
15:21:04     INFO -  'base_work_dir': 'C:\\slave\\test',
15:21:04     INFO -  'blob_upload_branch': 'Firefox-Non-PGO',
15:21:04     INFO -  'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
15:21:04     INFO -  'branch': 'Firefox-Non-PGO',
15:21:04     INFO -  'buildbot_json_path': 'buildprops.json',
15:21:04     INFO -  'config_files': ('talos/windows_config.py',),
15:21:04     INFO -  'default_actions': ('clobber',
15:21:04     INFO -                      'read-buildbot-config',
15:21:04     INFO -                      'download-and-extract',
15:21:04     INFO -                      'populate-webroot',
15:21:04     INFO -                      'create-virtualenv',
15:21:04     INFO -                      'install',
15:21:04     INFO -                      'run-tests'),
15:21:04     INFO -  'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
15:21:04     INFO -  'download_minidump_stackwalk': True,
15:21:04     INFO -  'download_symbols': 'ondemand',
15:21:04     INFO -  'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
15:21:04     INFO -                            'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
15:21:04     INFO -           'hg': 'c:/mozilla-build/hg/hg',
15:21:04     INFO -           'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
15:21:04     INFO -                          'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
15:21:04     INFO -           'python': 'c:/mozilla-build/python27/python.exe',
15:21:04     INFO -           'tooltool.py': ('c:/mozilla-build/python27/python.exe',
15:21:04     INFO -                           'C:/mozilla-build/tooltool.py'),
15:21:04     INFO -           'virtualenv': ('c:/mozilla-build/python27/python.exe',
15:21:04     INFO -                          'c:/mozilla-build/buildbotve/virtualenv.py')},
15:21:04     INFO -  'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
15:21:04     INFO -                 'http://pypi.pub.build.mozilla.org/pub'),
15:21:04     INFO -  'gecko_profile': False,
15:21:04     INFO -  'gecko_profile_interval': 0,
15:21:04     INFO -  'installer_path': 'installer.exe',
15:21:04     INFO -  'log_level': 'info',
15:21:04     INFO -  'log_name': 'talos',
15:21:04     INFO -  'log_to_console': True,
15:21:04     INFO -  'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
15:21:04     INFO -  'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
15:21:04     INFO -  'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
15:21:04     INFO -  'opt_config_files': (),
15:21:04     INFO -  'pip_index': False,
15:21:04     INFO -  'suite': 'dromaeojs-e10s',
15:21:04     INFO -  'system_bits': '32',
15:21:04     INFO -  'talos_extra_options': ('--webServer', 'localhost'),
15:21:04     INFO -  'title': 'T-W864-IX-084',
15:21:04     INFO -  'use_talos_json': True,
15:21:04     INFO -  'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
15:21:04     INFO -  'virtualenv_path': 'C:\\slave\\test\\build/venv',
15:21:04     INFO -  'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
15:21:04     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
15:21:04     INFO -  'work_dir': 'build'}
15:21:04     INFO - [mozharness: 2017-03-27 22:21:04.887000Z] Running clobber step.
15:21:04     INFO - Running pre-action listener: _resource_record_pre_action
15:21:04     INFO - Running main action method: clobber
15:21:04     INFO - rmtree: C:\slave\test\build
15:21:04     INFO - Using _rmtree_windows ...
15:21:04     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
15:22:48     INFO - Running post-action listener: _resource_record_post_action
15:22:48     INFO - [mozharness: 2017-03-27 22:22:48.081000Z] Finished clobber step (success)
15:22:48     INFO - [mozharness: 2017-03-27 22:22:48.081000Z] Running read-buildbot-config step.
15:22:48     INFO - Running pre-action listener: _resource_record_pre_action
15:22:48     INFO - Running main action method: read_buildbot_config
15:22:48     INFO - Using buildbot properties:
15:22:48     INFO - {
15:22:48     INFO -     "project": "", 
15:22:48     INFO -     "product": "firefox", 
15:22:48     INFO -     "script_repo_revision": "production", 
15:22:48     INFO -     "builddir": "mozilla-central_win8_64_test-dromaeojs-e10s", 
15:22:48     INFO -     "repository": "", 
15:22:48     INFO -     "buildername": "Windows 8 64-bit mozilla-central talos dromaeojs-e10s", 
15:22:48     INFO -     "buildid": "20170327142223", 
15:22:48     INFO -     "pgo_build": "False", 
15:22:48     INFO -     "basedir": "C:\\slave\\test", 
15:22:48     INFO -     "buildnumber": 56, 
15:22:48     INFO -     "slavename": "t-w864-ix-084", 
15:22:48     INFO -     "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 
15:22:48     INFO -     "platform": "win8_64", 
15:22:48     INFO -     "scheduler": "tests-mozilla-central-win64-talos", 
15:22:48     INFO -     "branch": "mozilla-central", 
15:22:48     INFO -     "repo_path": "mozilla-central", 
15:22:48     INFO -     "revision": "a6f35285bd1e674553527873614c55e0b7366bdb", 
15:22:48     INFO -     "stage_platform": "win64", 
15:22:48     INFO -     "builduid": "0806d6fb823c4450be886428cd087542", 
15:22:48     INFO -     "slavebuilddir": "test"
15:22:48     INFO - }
15:22:48     INFO - Found installer url https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip.
15:22:48     INFO - Running post-action listener: _resource_record_post_action
15:22:48     INFO - [mozharness: 2017-03-27 22:22:48.084000Z] Finished read-buildbot-config step (success)
15:22:48     INFO - [mozharness: 2017-03-27 22:22:48.084000Z] Running download-and-extract step.
15:22:48     INFO - Running pre-action listener: _resource_record_pre_action
15:22:48     INFO - Running main action method: download_and_extract
15:22:48     INFO - mkdir: C:\slave\test\build\tests
15:22:48     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')]}
15:22:48     INFO - trying https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.test_packages.json
15:22:48     INFO - Downloading https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/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
15:22:48     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/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
15:22:48     INFO - Downloaded 1408 bytes.
15:22:48     INFO - Reading from file C:\slave\test\build\firefox-55.0a1.en-US.win64.test_packages.json
15:22:48     INFO - Using the following test package requirements:
15:22:48     INFO - {u'awsy': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -            u'firefox-55.0a1.en-US.win64.awsy.tests.zip'],
15:22:48     INFO -  u'common': [u'firefox-55.0a1.en-US.win64.common.tests.zip'],
15:22:48     INFO -  u'cppunittest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -                   u'firefox-55.0a1.en-US.win64.cppunittest.tests.zip'],
15:22:48     INFO -  u'gtest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -             u'firefox-55.0a1.en-US.win64.gtest.tests.zip'],
15:22:48     INFO -  u'jittest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -               u'jsshell-win64.zip'],
15:22:48     INFO -  u'mochitest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -                 u'firefox-55.0a1.en-US.win64.mochitest.tests.zip'],
15:22:48     INFO -  u'mozbase': [u'firefox-55.0a1.en-US.win64.common.tests.zip'],
15:22:48     INFO -  u'reftest': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -               u'firefox-55.0a1.en-US.win64.reftest.tests.zip'],
15:22:48     INFO -  u'talos': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -             u'firefox-55.0a1.en-US.win64.talos.tests.zip'],
15:22:48     INFO -  u'web-platform': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -                    u'firefox-55.0a1.en-US.win64.web-platform.tests.zip'],
15:22:48     INFO -  u'xpcshell': [u'firefox-55.0a1.en-US.win64.common.tests.zip',
15:22:48     INFO -                u'firefox-55.0a1.en-US.win64.xpcshell.tests.zip']}
15:22:48     INFO - Downloading packages: [u'firefox-55.0a1.en-US.win64.common.tests.zip'] for test suite category: common
15:22:48     INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip
15:22:48     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip'}, attempt #1
15:22:48     INFO - Fetch https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip into memory
15:22:50     INFO - Expected file size: 53476758
15:22:50     INFO - Obtained file size: 53476758
15:23:46     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
15:23:46     INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip
15:23:46     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip'}, attempt #1
15:23:46     INFO - Fetch https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.common.tests.zip into memory
15:23:47     INFO - Expected file size: 53476758
15:23:47     INFO - Obtained file size: 53476758
15:24:10     INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.talos.tests.zip
15:24:10     INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.talos.tests.zip'}, attempt #1
15:24:10     INFO - Fetch https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.talos.tests.zip into memory
15:24:11     INFO - Expected file size: 14404171
15:24:11     INFO - Obtained file size: 14404171
15:24: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')]}
15:24:26     INFO - trying https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
15:24:26     INFO - Downloading https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip to C:\slave\test\build\firefox-55.0a1.en-US.win64.zip
15:24:26     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/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
15:24:27     INFO - Downloaded 60408554 bytes.
15:24:27     INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
15:24:27     INFO - mkdir: C:\slave\test\properties
15:24:27     INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
15:24:27     INFO - Writing to file C:\slave\test\properties\build_url
15:24:27     INFO - Contents:
15:24:27     INFO -  build_url:https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
15:24:28     INFO - Running post-action listener: _resource_record_post_action
15:24:28     INFO - Running post-action listener: set_extra_try_arguments
15:24:28     INFO - [mozharness: 2017-03-27 22:24:28.488000Z] Finished download-and-extract step (success)
15:24:28     INFO - [mozharness: 2017-03-27 22:24:28.488000Z] Running populate-webroot step.
15:24:28     INFO - Running pre-action listener: _resource_record_pre_action
15:24:28     INFO - Running main action method: populate_webroot
15:24:28     INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
15:24:28     INFO -  u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
15:24:28     INFO -                     u'remote-tsvgx': {u'talos_options': [u'--noChrome',
15:24:28     INFO -                                                          u'--tppagecycles',
15:24:28     INFO -                                                          u'7'],
15:24:28     INFO -                                       u'tests': [u'tsvgm']}},
15:24:28     INFO -  u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                           u'tests': [u'tresize', u'tcanvasmark']},
15:24:28     INFO -              u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
15:24:28     INFO -              u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                             u'tests': [u'dromaeo_css', u'kraken']},
15:24:28     INFO -              u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
15:24:28     INFO -              u'g1': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                      u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                      u'tests': [u'tp5o_scroll', u'glterrain']},
15:24:28     INFO -              u'g1-e10s': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                           u'tests': [u'tp5o_scroll', u'glterrain']},
15:24:28     INFO -              u'g2': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                      u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                      u'tests': [u'damp', u'tps']},
15:24:28     INFO -              u'g2-e10s': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                           u'tests': [u'damp', u'tps']},
15:24:28     INFO -              u'g3': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                      u'tests': [u'dromaeo_dom']},
15:24:28     INFO -              u'g3-e10s': {u'tests': [u'dromaeo_dom']},
15:24:28     INFO -              u'g4': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                      u'tests': [u'basic_compositor_video']},
15:24:28     INFO -              u'g4-e10s': {u'tests': [u'basic_compositor_video']},
15:24:28     INFO -              u'other': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                         u'tests': [u'a11yr',
15:24:28     INFO -                                    u'ts_paint',
15:24:28     INFO -                                    u'tpaint',
15:24:28     INFO -                                    u'sessionrestore',
15:24:28     INFO -                                    u'sessionrestore_no_auto_restore',
15:24:28     INFO -                                    u'tabpaint']},
15:24:28     INFO -              u'other-e10s': {u'tests': [u'a11yr',
15:24:28     INFO -                                         u'ts_paint',
15:24:28     INFO -                                         u'tpaint',
15:24:28     INFO -                                         u'sessionrestore',
15:24:28     INFO -                                         u'sessionrestore_no_auto_restore',
15:24:28     INFO -                                         u'tabpaint']},
15:24:28     INFO -              u'other-e10s_l64': {u'tests': [u'a11yr',
15:24:28     INFO -                                             u'ts_paint',
15:24:28     INFO -                                             u'tpaint',
15:24:28     INFO -                                             u'sessionrestore',
15:24:28     INFO -                                             u'sessionrestore_no_auto_restore',
15:24:28     INFO -                                             u'tabpaint']},
15:24:28     INFO -              u'other-e10s_nol64': {u'tests': [u'a11yr',
15:24:28     INFO -                                               u'ts_paint',
15:24:28     INFO -                                               u'tpaint',
15:24:28     INFO -                                               u'sessionrestore',
15:24:28     INFO -                                               u'sessionrestore_no_auto_restore',
15:24:28     INFO -                                               u'tabpaint']},
15:24:28     INFO -              u'other_l64': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                             u'tests': [u'a11yr',
15:24:28     INFO -                                        u'ts_paint',
15:24:28     INFO -                                        u'tpaint',
15:24:28     INFO -                                        u'sessionrestore',
15:24:28     INFO -                                        u'sessionrestore_no_auto_restore',
15:24:28     INFO -                                        u'tabpaint']},
15:24:28     INFO -              u'other_nol64': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                               u'tests': [u'a11yr',
15:24:28     INFO -                                          u'ts_paint',
15:24:28     INFO -                                          u'tpaint',
15:24:28     INFO -                                          u'sessionrestore',
15:24:28     INFO -                                          u'sessionrestore_no_auto_restore',
15:24:28     INFO -                                          u'tabpaint']},
15:24:28     INFO -              u'svgr': {u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                        u'tests': [u'tsvgx',
15:24:28     INFO -                                   u'tsvgr_opacity',
15:24:28     INFO -                                   u'tart',
15:24:28     INFO -                                   u'tscrollx',
15:24:28     INFO -                                   u'cart',
15:24:28     INFO -                                   u'tsvg_static']},
15:24:28     INFO -              u'svgr-e10s': {u'tests': [u'tsvgx',
15:24:28     INFO -                                        u'tsvgr_opacity',
15:24:28     INFO -                                        u'tart',
15:24:28     INFO -                                        u'tscrollx',
15:24:28     INFO -                                        u'cart',
15:24:28     INFO -                                        u'tsvg_static']},
15:24:28     INFO -              u'tp5o': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                        u'talos_options': [u'--disable-e10s'],
15:24:28     INFO -                        u'tests': [u'tp5o']},
15:24:28     INFO -              u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                             u'tests': [u'tp5o']},
15:24:28     INFO -              u'xperf': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                         u'talos_options': [u'--disable-e10s',
15:24:28     INFO -                                            u'--xperf_path',
15:24:28     INFO -                                            u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
15:24:28     INFO -                         u'tests': [u'tp5n']},
15:24:28     INFO -              u'xperf-e10s': {u'pagesets_name': u'tp5n.zip',
15:24:28     INFO -                              u'talos_options': [u'--xperf_path',
15:24:28     INFO -                                                 u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
15:24:28     INFO -                              u'tests': [u'tp5n']}},
15:24:28     INFO -  u'talos.zip': {u'path': u'',
15:24:28     INFO -                 u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
15:24:28     INFO - Running post-action listener: _resource_record_post_action
15:24:28     INFO - [mozharness: 2017-03-27 22:24:28.587000Z] Finished populate-webroot step (success)
15:24:28     INFO - [mozharness: 2017-03-27 22:24:28.587000Z] Running create-virtualenv step.
15:24:28     INFO - Running pre-action listener: _resource_record_pre_action
15:24:28     INFO - Running main action method: create_virtualenv
15:24:28     INFO - Creating virtualenv C:\slave\test\build/venv
15:24:28     INFO - mkdir: C:\slave\test\build\venv\Scripts
15:24:28     INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
15:24:28  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'!
15:24:28     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
15:24:28     INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
15:24:39     INFO -  New python executable in C:\slave\test\build/venv\Scripts\python.exe
15:24:42     INFO -  Installing distribute......................................................................................................................................................................................done.
15:24:43     INFO - Return code: 0
15:24:43     INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
15:24:43     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
15:24:43     INFO - Reading from file tmpfile_stdout
15:24:43     INFO - Output received:
15:24:43     INFO -  pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
15:24:43     INFO - Using _rmtree_windows ...
15:24:43     INFO - Using _rmtree_windows ...
15:24:43     INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
15:24:43     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')]}
15:24:43     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:24:43     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')]}
15:24:43     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:24:43     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:24:43     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
15:24:43     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
15:24:43     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:24:43     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:24:43     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:24:43     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:24:43     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:24:43     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:24:43     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:24:43     INFO -  'DCLOCATION': 'SCL3',
15:24:43     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:24:43     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:24:43     INFO -  'HOMEDRIVE': 'C:',
15:24:43     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:24:43     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:24:43     INFO -  'KTS_VERSION': '1.19c',
15:24:43     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:24:43     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:24:43     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:24:43     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:24:43     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:24:43     INFO -  'MOZ_NO_REMOTE': '1',
15:24:43     INFO -  'NO_EM_RESTART': '1',
15:24:43     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:24:43     INFO -  'OS': 'Windows_NT',
15:24:43     INFO -  'OURDRIVE': 'C:',
15:24:43     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',
15:24:43     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:24:43     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:24:43     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:24:43     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:24:43     INFO -  'PROCESSOR_LEVEL': '6',
15:24:43     INFO -  'PROCESSOR_REVISION': '1e05',
15:24:43     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:24:43     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:24:43     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:24:43     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:24:43     INFO -  'PROMPT': '$P$G',
15:24:43     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:24:43     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:24:43     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:24:43     INFO -  'PWD': 'C:\\slave\\test',
15:24:43     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:24:43     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:24:43     INFO -  'SYSTEMDRIVE': 'C:',
15:24:43     INFO -  'SYSTEMROOT': 'C:\\windows',
15:24:43     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:43     INFO -  'TEST1': 'testie',
15:24:43     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:43     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:24:43     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:24:43     INFO -  'USERNAME': 'cltbld',
15:24:43     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:24:43     INFO -  'WINDIR': 'C:\\windows',
15:24:43     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:24:44     INFO -  Ignoring indexes: http://pypi.python.org/simple/
15:24:44     INFO -  Downloading/unpacking pip>=1.5
15:24:49     INFO -    Running setup.py egg_info for package pip
15:24:49     INFO -      warning: no files found matching 'pip\cacert.pem'
15:24:49     INFO -      warning: no files found matching '*.html' under directory 'docs'
15:24:49     INFO -      warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
15:24:49     INFO -      no previously-included directories found matching 'docs\_build\_sources'
15:24:49     INFO -  Installing collected packages: pip
15:24:49     INFO -    Found existing installation: pip 0.8.2
15:24:49     INFO -      Uninstalling pip:
15:24:49     INFO -        Successfully uninstalled pip
15:24:49     INFO -    Running setup.py install for pip
15:24:49     INFO -      warning: no files found matching 'pip\cacert.pem'
15:24:49     INFO -      warning: no files found matching '*.html' under directory 'docs'
15:24:49     INFO -      warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
15:24:49     INFO -      no previously-included directories found matching 'docs\_build\_sources'
15:24:49     INFO -      Installing pip-script.py script to C:\slave\test\build\venv\Scripts
15:24:49     INFO -      Installing pip.exe script to C:\slave\test\build\venv\Scripts
15:24:49     INFO -      Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
15:24:49     INFO -      Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
15:24:49     INFO -      Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
15:24:49     INFO -      Installing pip2.exe script to C:\slave\test\build\venv\Scripts
15:24:49     INFO -  Successfully installed pip
15:24:49     INFO -  Cleaning up...
15:24:49     INFO - Return code: 0
15:24:49     INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
15:24:49     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')]}
15:24:49     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:24:49     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')]}
15:24:49     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:24:49     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:24:49     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
15:24:49     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
15:24:49     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:24:49     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:24:49     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:24:49     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:24:49     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:24:49     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:24:49     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:24:49     INFO -  'DCLOCATION': 'SCL3',
15:24:49     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:24:49     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:24:49     INFO -  'HOMEDRIVE': 'C:',
15:24:49     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:24:49     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:24:49     INFO -  'KTS_VERSION': '1.19c',
15:24:49     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:24:49     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:24:49     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:24:49     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:24:49     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:24:49     INFO -  'MOZ_NO_REMOTE': '1',
15:24:49     INFO -  'NO_EM_RESTART': '1',
15:24:49     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:24:49     INFO -  'OS': 'Windows_NT',
15:24:49     INFO -  'OURDRIVE': 'C:',
15:24:49     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',
15:24:49     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:24:49     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:24:49     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:24:49     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:24:49     INFO -  'PROCESSOR_LEVEL': '6',
15:24:49     INFO -  'PROCESSOR_REVISION': '1e05',
15:24:49     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:24:49     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:24:49     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:24:49     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:24:49     INFO -  'PROMPT': '$P$G',
15:24:49     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:24:49     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:24:49     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:24:49     INFO -  'PWD': 'C:\\slave\\test',
15:24:49     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:24:49     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:24:49     INFO -  'SYSTEMDRIVE': 'C:',
15:24:49     INFO -  'SYSTEMROOT': 'C:\\windows',
15:24:49     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:49     INFO -  'TEST1': 'testie',
15:24:49     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:49     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:24:49     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:24:49     INFO -  'USERNAME': 'cltbld',
15:24:49     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:24:49     INFO -  'WINDIR': 'C:\\windows',
15:24:49     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:24:51     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:24:51     INFO -  Downloading/unpacking psutil>=3.1.1
15:24:51     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
15:24:51     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
15:24:52     INFO -  Installing collected packages: psutil
15:24:52     INFO -  Successfully installed psutil
15:24:52     INFO -  Cleaning up...
15:24:52     INFO - Return code: 0
15:24:52     INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
15:24: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')]}
15:24:52     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:24: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')]}
15:24:52     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:24:52     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:24:52     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
15:24:52     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
15:24:52     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:24:52     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:24:52     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:24:52     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:24:52     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:24:52     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:24:52     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:24:52     INFO -  'DCLOCATION': 'SCL3',
15:24:52     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:24:52     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:24:52     INFO -  'HOMEDRIVE': 'C:',
15:24:52     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:24:52     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:24:52     INFO -  'KTS_VERSION': '1.19c',
15:24:52     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:24:52     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:24:52     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:24:52     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:24:52     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:24:52     INFO -  'MOZ_NO_REMOTE': '1',
15:24:52     INFO -  'NO_EM_RESTART': '1',
15:24:52     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:24:52     INFO -  'OS': 'Windows_NT',
15:24:52     INFO -  'OURDRIVE': 'C:',
15:24: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',
15:24:52     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:24:52     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:24:52     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:24:52     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:24:52     INFO -  'PROCESSOR_LEVEL': '6',
15:24:52     INFO -  'PROCESSOR_REVISION': '1e05',
15:24:52     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:24:52     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:24:52     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:24:52     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:24:52     INFO -  'PROMPT': '$P$G',
15:24:52     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:24:52     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:24:52     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:24:52     INFO -  'PWD': 'C:\\slave\\test',
15:24:52     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:24:52     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:24:52     INFO -  'SYSTEMDRIVE': 'C:',
15:24:52     INFO -  'SYSTEMROOT': 'C:\\windows',
15:24:52     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:52     INFO -  'TEST1': 'testie',
15:24:52     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:52     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:24:52     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:24:52     INFO -  'USERNAME': 'cltbld',
15:24:52     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:24:52     INFO -  'WINDIR': 'C:\\windows',
15:24:52     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:24:52     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:24:52     INFO -  Downloading/unpacking mozsystemmonitor==0.3
15:24:52     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
15:24:52     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
15:24:53     INFO -    Downloading mozsystemmonitor-0.3.tar.gz
15:24:53     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
15:24:53     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)
15:24:53     INFO -  Installing collected packages: mozsystemmonitor
15:24:53     INFO -    Running setup.py install for mozsystemmonitor
15:24:54     INFO -  Successfully installed mozsystemmonitor
15:24:54     INFO -  Cleaning up...
15:24:54     INFO - Return code: 0
15:24:54     INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
15:24:54     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')]}
15:24:54     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:24:54     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')]}
15:24:54     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:24:54     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:24:54     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
15:24:54     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
15:24:54     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:24:54     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:24:54     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:24:54     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:24:54     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:24:54     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:24:54     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:24:54     INFO -  'DCLOCATION': 'SCL3',
15:24:54     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:24:54     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:24:54     INFO -  'HOMEDRIVE': 'C:',
15:24:54     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:24:54     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:24:54     INFO -  'KTS_VERSION': '1.19c',
15:24:54     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:24:54     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:24:54     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:24:54     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:24:54     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:24:54     INFO -  'MOZ_NO_REMOTE': '1',
15:24:54     INFO -  'NO_EM_RESTART': '1',
15:24:54     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:24:54     INFO -  'OS': 'Windows_NT',
15:24:54     INFO -  'OURDRIVE': 'C:',
15:24:54     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',
15:24:54     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:24:54     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:24:54     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:24:54     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:24:54     INFO -  'PROCESSOR_LEVEL': '6',
15:24:54     INFO -  'PROCESSOR_REVISION': '1e05',
15:24:54     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:24:54     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:24:54     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:24:54     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:24:54     INFO -  'PROMPT': '$P$G',
15:24:54     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:24:54     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:24:54     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:24:54     INFO -  'PWD': 'C:\\slave\\test',
15:24:54     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:24:54     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:24:54     INFO -  'SYSTEMDRIVE': 'C:',
15:24:54     INFO -  'SYSTEMROOT': 'C:\\windows',
15:24:54     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:54     INFO -  'TEST1': 'testie',
15:24:54     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:54     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:24:54     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:24:54     INFO -  'USERNAME': 'cltbld',
15:24:54     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:24:54     INFO -  'WINDIR': 'C:\\windows',
15:24:54     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:24:55     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:24:55     INFO -  Downloading/unpacking jsonschema==2.5.1
15:24:55     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
15:24:55     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
15:24:56     INFO -    Downloading jsonschema-2.5.1-py2.py3-none-any.whl
15:24:56     INFO -  Downloading/unpacking functools32 (from jsonschema==2.5.1)
15:24:56     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
15:24:56     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
15:24:56     INFO -    Downloading functools32-3.2.3-2.tar.gz
15:24:56     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
15:24:56     INFO -      warning: no files found matching '*.txt'
15:24:56     INFO -      no previously-included directories found matching 'build'
15:24:56     INFO -      no previously-included directories found matching 'dist'
15:24:56     INFO -      no previously-included directories found matching '.git*'
15:24:56     INFO -  Installing collected packages: jsonschema, functools32
15:24:56     INFO -    Running setup.py install for functools32
15:24:56     INFO -      warning: no files found matching '*.txt'
15:24:56     INFO -      no previously-included directories found matching 'build'
15:24:56     INFO -      no previously-included directories found matching 'dist'
15:24:56     INFO -      no previously-included directories found matching '.git*'
15:24:56     INFO -  Successfully installed jsonschema functools32
15:24:56     INFO -  Cleaning up...
15:24:57     INFO - Return code: 0
15:24:57     INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
15:24:57     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')]}
15:24:57     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:24:57     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')]}
15:24:57     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:24:57     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:24:57     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
15:24:57     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
15:24:57     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:24:57     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:24:57     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:24:57     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:24:57     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:24:57     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:24:57     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:24:57     INFO -  'DCLOCATION': 'SCL3',
15:24:57     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:24:57     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:24:57     INFO -  'HOMEDRIVE': 'C:',
15:24:57     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:24:57     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:24:57     INFO -  'KTS_VERSION': '1.19c',
15:24:57     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:24:57     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:24:57     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:24:57     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:24:57     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:24:57     INFO -  'MOZ_NO_REMOTE': '1',
15:24:57     INFO -  'NO_EM_RESTART': '1',
15:24:57     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:24:57     INFO -  'OS': 'Windows_NT',
15:24:57     INFO -  'OURDRIVE': 'C:',
15:24:57     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',
15:24:57     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:24:57     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:24:57     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:24:57     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:24:57     INFO -  'PROCESSOR_LEVEL': '6',
15:24:57     INFO -  'PROCESSOR_REVISION': '1e05',
15:24:57     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:24:57     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:24:57     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:24:57     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:24:57     INFO -  'PROMPT': '$P$G',
15:24:57     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:24:57     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:24:57     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:24:57     INFO -  'PWD': 'C:\\slave\\test',
15:24:57     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:24:57     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:24:57     INFO -  'SYSTEMDRIVE': 'C:',
15:24:57     INFO -  'SYSTEMROOT': 'C:\\windows',
15:24:57     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:57     INFO -  'TEST1': 'testie',
15:24:57     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:57     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:24:57     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:24:57     INFO -  'USERNAME': 'cltbld',
15:24:57     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:24:57     INFO -  'WINDIR': 'C:\\windows',
15:24:57     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:24:57     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:24:57     INFO -  Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
15:24:57     INFO -  Cleaning up...
15:24:57     INFO - Return code: 0
15:24:57     INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
15:24:57     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')]}
15:24:57     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:24:57     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')]}
15:24:57     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:24:57     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:24:57     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
15:24:57     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
15:24:57     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:24:57     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:24:57     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:24:57     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:24:57     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:24:57     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:24:57     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:24:57     INFO -  'DCLOCATION': 'SCL3',
15:24:57     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:24:57     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:24:57     INFO -  'HOMEDRIVE': 'C:',
15:24:57     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:24:57     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:24:57     INFO -  'KTS_VERSION': '1.19c',
15:24:57     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:24:57     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:24:57     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:24:57     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:24:57     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:24:57     INFO -  'MOZ_NO_REMOTE': '1',
15:24:57     INFO -  'NO_EM_RESTART': '1',
15:24:57     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:24:57     INFO -  'OS': 'Windows_NT',
15:24:57     INFO -  'OURDRIVE': 'C:',
15:24:57     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',
15:24:57     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:24:57     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:24:57     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:24:57     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:24:57     INFO -  'PROCESSOR_LEVEL': '6',
15:24:57     INFO -  'PROCESSOR_REVISION': '1e05',
15:24:57     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:24:57     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:24:57     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:24:57     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:24:57     INFO -  'PROMPT': '$P$G',
15:24:57     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:24:57     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:24:57     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:24:57     INFO -  'PWD': 'C:\\slave\\test',
15:24:57     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:24:57     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:24:57     INFO -  'SYSTEMDRIVE': 'C:',
15:24:57     INFO -  'SYSTEMROOT': 'C:\\windows',
15:24:57     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:57     INFO -  'TEST1': 'testie',
15:24:57     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:24:57     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:24:57     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:24:57     INFO -  'USERNAME': 'cltbld',
15:24:57     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:24:57     INFO -  'WINDIR': 'C:\\windows',
15:24:57     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:24:57     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:24:57     INFO -  Downloading/unpacking blobuploader==1.2.4
15:24:57     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
15:24:57     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
15:24:58     INFO -    Downloading blobuploader-1.2.4.tar.gz
15:24:58     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
15:24:59     INFO -  Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
15:24:59     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
15:24:59     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
15:24:59     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
15:24:59     INFO -  Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
15:24:59     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
15:24:59     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
15:24:59     INFO -    Downloading docopt-0.6.1.tar.gz
15:24:59     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
15:24:59     INFO -  Installing collected packages: blobuploader, requests, docopt
15:24:59     INFO -    Running setup.py install for blobuploader
15:24:59     INFO -    Running setup.py install for requests
15:25:00     INFO -    Running setup.py install for docopt
15:25:00     INFO -  Successfully installed blobuploader requests docopt
15:25:00     INFO -  Cleaning up...
15:25:01     INFO - Return code: 0
15:25:01     INFO - Installing None into virtualenv C:\slave\test\build/venv
15:25: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')]}
15:25:01     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:25: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')]}
15:25:01     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:25:01     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, '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-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:25:01     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
15:25:01     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
15:25:01     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:25:01     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:25:01     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:25:01     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:25:01     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:25:01     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:25:01     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:25:01     INFO -  'DCLOCATION': 'SCL3',
15:25:01     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:25:01     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:25:01     INFO -  'HOMEDRIVE': 'C:',
15:25:01     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:25:01     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:25:01     INFO -  'KTS_VERSION': '1.19c',
15:25:01     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:25:01     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:25:01     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:25:01     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:25:01     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:25:01     INFO -  'MOZ_NO_REMOTE': '1',
15:25:01     INFO -  'NO_EM_RESTART': '1',
15:25:01     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:25:01     INFO -  'OS': 'Windows_NT',
15:25:01     INFO -  'OURDRIVE': 'C:',
15:25:01     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',
15:25:01     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:25:01     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:25:01     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:25:01     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:25:01     INFO -  'PROCESSOR_LEVEL': '6',
15:25:01     INFO -  'PROCESSOR_REVISION': '1e05',
15:25:01     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:25:01     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:25:01     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:25:01     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:25:01     INFO -  'PROMPT': '$P$G',
15:25:01     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:25:01     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:25:01     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:25:01     INFO -  'PWD': 'C:\\slave\\test',
15:25:01     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:25:01     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:25:01     INFO -  'SYSTEMDRIVE': 'C:',
15:25:01     INFO -  'SYSTEMROOT': 'C:\\windows',
15:25:01     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:01     INFO -  'TEST1': 'testie',
15:25:01     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:01     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:25:01     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:25:01     INFO -  'USERNAME': 'cltbld',
15:25:01     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:25:01     INFO -  'WINDIR': 'C:\\windows',
15:25:01     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:25:02     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\manifestparser
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qunxkm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozcrash
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x1gd5u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdebug
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dd13jo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdevice
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ojijcn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozfile
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3yy0le-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-owomn4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinfo
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kpvn59-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinstall
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vjahec-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
15:25:02     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozleak
15:25:02     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y3jf5j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozlog
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-30zctp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moznetwork
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_wsavv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprocess
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vw1dlv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprofile
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xv22wc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozrunner
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u2idrk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uctnep-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moztest
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o2_flj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
15:25:03     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozversion
15:25:03     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-robsku-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
15:25:03     INFO -  Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
15:25:03     INFO -    Running setup.py install for manifestparser
15:25:04     INFO -      Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
15:25:04     INFO -      Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
15:25:04     INFO -    Running setup.py install for mozcrash
15:25:04     INFO -    Running setup.py install for mozdebug
15:25:05     INFO -    Running setup.py install for mozdevice
15:25:05     INFO -      Installing dm-script.py script to C:\slave\test\build\venv\Scripts
15:25:05     INFO -      Installing dm.exe script to C:\slave\test\build\venv\Scripts
15:25:05     INFO -    Running setup.py install for mozfile
15:25:06     INFO -    Running setup.py install for mozhttpd
15:25:06     INFO -      Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
15:25:06     INFO -      Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
15:25:06     INFO -    Running setup.py install for mozinfo
15:25:07     INFO -      Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -    Running setup.py install for mozInstall
15:25:07     INFO -      Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -      Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
15:25:07     INFO -    Running setup.py install for mozleak
15:25:07     INFO -    Running setup.py install for mozlog
15:25:08     INFO -      Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
15:25:08     INFO -      Installing structlog.exe script to C:\slave\test\build\venv\Scripts
15:25:08     INFO -    Running setup.py install for moznetwork
15:25:08     INFO -      Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
15:25:08     INFO -      Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
15:25:09     INFO -    Running setup.py install for mozprocess
15:25:09     INFO -    Running setup.py install for mozprofile
15:25:09     INFO -      Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
15:25:09     INFO -      Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
15:25:09     INFO -      Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
15:25:09     INFO -      Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
15:25:09     INFO -      Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
15:25:09     INFO -      Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
15:25:10     INFO -    Running setup.py install for mozrunner
15:25:10     INFO -      Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
15:25:10     INFO -      Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
15:25:11     INFO -    Running setup.py install for mozscreenshot
15:25:11     INFO -    Running setup.py install for moztest
15:25:12     INFO -    Running setup.py install for mozversion
15:25:12     INFO -      Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
15:25:12     INFO -      Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
15:25:12     INFO -  Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
15:25:12     INFO -  Cleaning up...
15:25:12     INFO - Return code: 0
15:25:12     INFO - Installing None into virtualenv C:\slave\test\build/venv
15:25:12     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')]}
15:25:12     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:25:12     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')]}
15:25:12     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:25:12     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, '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-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:25:12     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
15:25:12     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
15:25:12     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:25:12     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:25:12     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:25:12     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:25:12     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:25:12     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:25:12     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:25:12     INFO -  'DCLOCATION': 'SCL3',
15:25:12     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:25:12     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:25:12     INFO -  'HOMEDRIVE': 'C:',
15:25:12     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:25:12     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:25:12     INFO -  'KTS_VERSION': '1.19c',
15:25:12     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:25:12     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:25:12     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:25:12     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:25:12     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:25:12     INFO -  'MOZ_NO_REMOTE': '1',
15:25:12     INFO -  'NO_EM_RESTART': '1',
15:25:12     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:25:12     INFO -  'OS': 'Windows_NT',
15:25:12     INFO -  'OURDRIVE': 'C:',
15:25:12     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',
15:25:12     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:25:12     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:25:12     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:25:12     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:25:12     INFO -  'PROCESSOR_LEVEL': '6',
15:25:12     INFO -  'PROCESSOR_REVISION': '1e05',
15:25:12     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:25:12     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:25:12     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:25:12     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:25:12     INFO -  'PROMPT': '$P$G',
15:25:12     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:25:12     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:25:12     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:25:12     INFO -  'PWD': 'C:\\slave\\test',
15:25:12     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:25:12     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:25:12     INFO -  'SYSTEMDRIVE': 'C:',
15:25:12     INFO -  'SYSTEMROOT': 'C:\\windows',
15:25:12     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:12     INFO -  'TEST1': 'testie',
15:25:12     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:12     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:25:12     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:25:12     INFO -  'USERNAME': 'cltbld',
15:25:12     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:25:12     INFO -  'WINDIR': 'C:\\windows',
15:25:12     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:25:12     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\manifestparser
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xxf9ic-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozcrash
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l97wxi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdebug
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v7q9ga-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozdevice
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aqqlfn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
15:25:13     INFO -    Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozfile
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fvxvuz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-prayvg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinfo
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4qkl6l-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozinstall
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rmxxce-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
15:25:13     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))
15:25:13     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozleak
15:25:13     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rsipo4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
15:25:14     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))
15:25:14     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozlog
15:25:14     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-n3hjnq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
15:25:14     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))
15:25:14     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moznetwork
15:25:14     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fl1w8a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
15:25:14     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))
15:25:14     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprocess
15:25:14     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nmjmb4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
15:25:14     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))
15:25:14     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozprofile
15:25:14     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rmciop-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
15:25:14     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))
15:25:14     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozrunner
15:25:14     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wezhbr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
15:25:14     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))
15:25:14     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
15:25:14     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gza3w0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
15:25:15     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))
15:25:15     INFO -  Unpacking c:\slave\test\build\tests\mozbase\moztest
15:25:15     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1uj8ik-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
15:25:15     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))
15:25:15     INFO -  Unpacking c:\slave\test\build\tests\mozbase\mozversion
15:25:15     INFO -    Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z_goqn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
15:25:15     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))
15:25:15     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))
15:25:15     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))
15:25:15     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))
15:25:15     INFO -  Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
15:25:15     INFO -  Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
15:25:15     INFO -  Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
15:25:15     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
15:25:15     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
15:25:16     INFO -    Downloading blessings-1.6.tar.gz
15:25:16     INFO -    Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
15:25:16     INFO -  Installing collected packages: blessings
15:25:16     INFO -    Running setup.py install for blessings
15:25:16     INFO -  Successfully installed blessings
15:25:16     INFO -  Cleaning up...
15:25:19     INFO - Return code: 0
15:25:19     INFO - Done creating virtualenv C:\slave\test\build/venv.
15:25:19     INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
15:25:19     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
15:25:20     INFO - Reading from file tmpfile_stdout
15:25:20     INFO - Using _rmtree_windows ...
15:25:20     INFO - Using _rmtree_windows ...
15:25:20     INFO - Current package versions:
15:25:20     INFO -   blessings == 1.6
15:25:20     INFO -   blobuploader == 1.2.4
15:25:20     INFO -   docopt == 0.6.1
15:25:20     INFO -   functools32 == 3.2.3-2
15:25:20     INFO -   jsonschema == 2.5.1
15:25:20     INFO -   manifestparser == 1.1
15:25:20     INFO -   mozInstall == 1.12
15:25:20     INFO -   mozcrash == 1.0
15:25:20     INFO -   mozdebug == 0.1
15:25:20     INFO -   mozdevice == 0.49
15:25:20     INFO -   mozfile == 1.2
15:25:20     INFO -   mozhttpd == 0.7
15:25:20     INFO -   mozinfo == 0.9
15:25:20     INFO -   mozleak == 0.1
15:25:20     INFO -   mozlog == 3.4
15:25:20     INFO -   moznetwork == 0.27
15:25:20     INFO -   mozprocess == 0.25
15:25:20     INFO -   mozprofile == 0.28
15:25:20     INFO -   mozrunner == 6.13
15:25:20     INFO -   mozscreenshot == 0.1
15:25:20     INFO -   mozsystemmonitor == 0.3
15:25:20     INFO -   moztest == 0.8
15:25:20     INFO -   mozversion == 1.4
15:25:20     INFO -   psutil == 3.1.1
15:25:20     INFO -   requests == 1.2.3
15:25:20     INFO - Installing None into virtualenv C:\slave\test\build/venv
15:25:20     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')]}
15:25:20     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:25:20     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')]}
15:25:20     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:25:20     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, '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-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:25:20     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
15:25:20     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
15:25:20     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:25:20     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:25:20     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:25:20     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:25:20     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:25:20     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:25:20     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:25:20     INFO -  'DCLOCATION': 'SCL3',
15:25:20     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:25:20     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:25:20     INFO -  'HOMEDRIVE': 'C:',
15:25:20     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:25:20     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:25:20     INFO -  'KTS_VERSION': '1.19c',
15:25:20     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:25:20     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:25:20     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:25:20     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:25:20     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:25:20     INFO -  'MOZ_NO_REMOTE': '1',
15:25:20     INFO -  'NO_EM_RESTART': '1',
15:25:20     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:25:20     INFO -  'OS': 'Windows_NT',
15:25:20     INFO -  'OURDRIVE': 'C:',
15:25:20     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',
15:25:20     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:25:20     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:25:20     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:25:20     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:25:20     INFO -  'PROCESSOR_LEVEL': '6',
15:25:20     INFO -  'PROCESSOR_REVISION': '1e05',
15:25:20     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:25:20     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:25:20     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:25:20     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:25:20     INFO -  'PROMPT': '$P$G',
15:25:20     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:25:20     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:25:20     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:25:20     INFO -  'PWD': 'C:\\slave\\test',
15:25:20     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:25:20     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:25:20     INFO -  'SYSTEMDRIVE': 'C:',
15:25:20     INFO -  'SYSTEMROOT': 'C:\\windows',
15:25:20     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:20     INFO -  'TEST1': 'testie',
15:25:20     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:20     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:25:20     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:25:20     INFO -  'USERNAME': 'cltbld',
15:25:20     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:25:20     INFO -  'WINDIR': 'C:\\windows',
15:25:20     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:25:20     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     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))
15:25:20     INFO -  Cleaning up...
15:25:20     INFO - Return code: 0
15:25:20     INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
15:25:20     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')]}
15:25:20     INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:25:20     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')]}
15:25:20     INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:25:20     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 0x021E3870>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x027F5110>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0237C7D8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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
15:25:20     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
15:25:20     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
15:25:20     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:25:20     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:25:20     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:25:20     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:25:20     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:25:20     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:25:20     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:25:20     INFO -  'DCLOCATION': 'SCL3',
15:25:20     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:25:20     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:25:20     INFO -  'HOMEDRIVE': 'C:',
15:25:20     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:25:20     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:25:20     INFO -  'KTS_VERSION': '1.19c',
15:25:20     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:25:20     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:25:20     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:25:20     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:25:20     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:25:20     INFO -  'MOZ_NO_REMOTE': '1',
15:25:20     INFO -  'NO_EM_RESTART': '1',
15:25:20     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:25:20     INFO -  'OS': 'Windows_NT',
15:25:20     INFO -  'OURDRIVE': 'C:',
15:25:20     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',
15:25:20     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:25:20     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:25:20     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:25:20     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:25:20     INFO -  'PROCESSOR_LEVEL': '6',
15:25:20     INFO -  'PROCESSOR_REVISION': '1e05',
15:25:20     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:25:20     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:25:20     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:25:20     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:25:20     INFO -  'PROMPT': '$P$G',
15:25:20     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:25:20     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:25:20     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:25:20     INFO -  'PWD': 'C:\\slave\\test',
15:25:20     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:25:20     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:25:20     INFO -  'SYSTEMDRIVE': 'C:',
15:25:20     INFO -  'SYSTEMROOT': 'C:\\windows',
15:25:20     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:20     INFO -  'TEST1': 'testie',
15:25:20     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:20     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:25:20     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:25:20     INFO -  'USERNAME': 'cltbld',
15:25:20     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:25:20     INFO -  'WINDIR': 'C:\\windows',
15:25:20     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:25:20     INFO -  Ignoring indexes: https://pypi.python.org/simple/
15:25:20     INFO -  Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
15:25:20     INFO -  Cleaning up...
15:25:20     INFO - Return code: 0
15:25:20     INFO - Running post-action listener: _resource_record_post_action
15:25:20     INFO - Running post-action listener: _start_resource_monitoring
15:25:20     INFO - Starting resource monitoring.
15:25:20     INFO - [mozharness: 2017-03-27 22:25:20.891000Z] Finished create-virtualenv step (success)
15:25:20     INFO - [mozharness: 2017-03-27 22:25:20.892000Z] Running install step.
15:25:20     INFO - Running pre-action listener: _resource_record_pre_action
15:25:20     INFO - Running main action method: install
15:25:20     INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
15:25:20     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
15:25:21     INFO - Reading from file tmpfile_stdout
15:25:21     INFO - Using _rmtree_windows ...
15:25:21     INFO - Using _rmtree_windows ...
15:25:21     INFO - Detecting whether we're running mozinstall >=1.0...
15:25:21     INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
15:25:21     INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
15:25:21     INFO - Reading from file tmpfile_stdout
15:25:21     INFO - Output received:
15:25:21     INFO -  Usage: mozinstall-script.py [options] installer
15:25:21     INFO -  Options:
15:25:21     INFO -    -h, --help            show this help message and exit
15:25:21     INFO -    -d DEST, --destination=DEST
15:25:21     INFO -                          Directory to install application into. [default:
15:25:21     INFO -                          "C:\slave\test"]
15:25:21     INFO -    --app=APP             Application being installed. [default: firefox]
15:25:21     INFO - Using _rmtree_windows ...
15:25:21     INFO - Using _rmtree_windows ...
15:25:21     INFO - mkdir: C:\slave\test\build\application
15:25:21     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']
15:25:21     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
15:25:23     INFO - Reading from file tmpfile_stdout
15:25:23     INFO - Output received:
15:25:23     INFO -  C:\slave\test\build\application\firefox\firefox.exe
15:25:23     INFO - Using _rmtree_windows ...
15:25:23     INFO - Using _rmtree_windows ...
15:25:23     INFO - Running post-action listener: _resource_record_post_action
15:25:23     INFO - [mozharness: 2017-03-27 22:25:23.122000Z] Finished install step (success)
15:25:23     INFO - [mozharness: 2017-03-27 22:25:23.122000Z] Running run-tests step.
15:25:23     INFO - Running pre-action listener: _resource_record_pre_action
15:25:23     INFO - Running main action method: run_tests
15:25:23     INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
15:25:23     INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
15:25:23     INFO -  Python 2.7.3
15:25:23     INFO - Return code: 0
15:25:23     INFO - grabbing minidump binary from tooltool
15:25:23     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')]}
15:25:23     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 0x028000C8>, '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 0x01CDA9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023235C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
15:25:23     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
15:25:23     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
15:25:23     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
15:25:23     INFO -  INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
15:25:23     INFO -  INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpjykqlx
15:25:23     INFO -  INFO - File integrity verified, renaming tmpjykqlx to win32-minidump_stackwalk.exe
15:25:23     INFO - Return code: 0
15:25:23     INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
15:25:23     INFO - mkdir: C:\slave\test\build\blobber_upload_dir
15:25:23     INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
15:25:23     INFO - ENV: RUST_BACKTRACE is now 1
15:25:23     INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
15:25:23     INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
15:25:23     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/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-084', '--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
15:25:23     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/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-084 --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
15:25:24     INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:25:24     INFO -  'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming',
15:25:24     INFO -  'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:25:24     INFO -  'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:25:24     INFO -  'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:25:24     INFO -  'COMPUTERNAME': 'T-W864-IX-084',
15:25:24     INFO -  'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:25:24     INFO -  'DCLOCATION': 'SCL3',
15:25:24     INFO -  'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:25:24     INFO -  'FP_NO_HOST_CHECK': 'NO',
15:25:24     INFO -  'HOMEDRIVE': 'C:',
15:25:24     INFO -  'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084',
15:25:24     INFO -  'KTS_HOME': 'C:\\Program Files\\KTS',
15:25:24     INFO -  'KTS_VERSION': '1.19c',
15:25:24     INFO -  'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local',
15:25:24     INFO -  'LOGONSERVER': '\\\\T-W864-IX-084',
15:25:24     INFO -  'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
15:25:24     INFO -  'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
15:25:24     INFO -  'MONDIR': 'C:\\Monitor_config\\',
15:25:24     INFO -  'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:25:24     INFO -  'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:25:24     INFO -  'MOZ_NO_REMOTE': '1',
15:25:24     INFO -  'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
15:25:24     INFO -  'NO_EM_RESTART': '1',
15:25:24     INFO -  'NUMBER_OF_PROCESSORS': '8',
15:25:24     INFO -  'OS': 'Windows_NT',
15:25:24     INFO -  'OURDRIVE': 'C:',
15:25:24     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',
15:25:24     INFO -  'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:25:24     INFO -  'PROCESSOR_ARCHITECTURE': 'x86',
15:25:24     INFO -  'PROCESSOR_ARCHITEW6432': 'AMD64',
15:25:24     INFO -  'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:25:24     INFO -  'PROCESSOR_LEVEL': '6',
15:25:24     INFO -  'PROCESSOR_REVISION': '1e05',
15:25:24     INFO -  'PROGRAMDATA': 'C:\\ProgramData',
15:25:24     INFO -  'PROGRAMFILES': 'C:\\Program Files (x86)',
15:25:24     INFO -  'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:25:24     INFO -  'PROGRAMW6432': 'C:\\Program Files',
15:25:24     INFO -  'PROMPT': '$P$G',
15:25:24     INFO -  'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:25:24     INFO -  'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:25:24     INFO -  'PUBLIC': 'C:\\Users\\Public',
15:25:24     INFO -  'PWD': 'C:\\slave\\test',
15:25:24     INFO -  'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
15:25:24     INFO -  'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:25:24     INFO -  'RUST_BACKTRACE': '1',
15:25:24     INFO -  'SLAVEDIR': 'C:\\slave\\',
15:25:24     INFO -  'SYSTEMDRIVE': 'C:',
15:25:24     INFO -  'SYSTEMROOT': 'C:\\windows',
15:25:24     INFO -  'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:24     INFO -  'TEST1': 'testie',
15:25:24     INFO -  'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:25:24     INFO -  'USERDOMAIN': 'T-W864-IX-084',
15:25:24     INFO -  'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084',
15:25:24     INFO -  'USERNAME': 'cltbld',
15:25:24     INFO -  'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084',
15:25:24     INFO -  'WINDIR': 'C:\\windows',
15:25:24     INFO -  'XPCOM_DEBUG_BREAK': 'warn'}
15:25:24     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/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-084', '--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
15:25:24     INFO -  mozversion application_buildid: 20170327142223
15:25:24     INFO -  mozversion application_changeset: a6f35285bd1e674553527873614c55e0b7366bdb
15:25:24     INFO -  mozversion application_display_name: Nightly
15:25:24     INFO -  mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
15:25:24     INFO -  mozversion application_name: Firefox
15:25:24     INFO -  mozversion application_remotingname: firefox
15:25:24     INFO -  mozversion application_repository: https://hg.mozilla.org/mozilla-central
15:25:24     INFO -  mozversion application_vendor: Mozilla
15:25:24     INFO -  mozversion application_version: 55.0a1
15:25:24     INFO -  mozversion platform_buildid: 20170327142223
15:25:24     INFO -  mozversion platform_changeset: a6f35285bd1e674553527873614c55e0b7366bdb
15:25:24     INFO -  mozversion platform_repository: https://hg.mozilla.org/mozilla-central
15:25:24     INFO -  mozversion platform_version: 55.0a1
15:25:24     INFO -  using testdate: 1490653524
15:25:24     INFO -  actual date: 1490653524
15:25:24     INFO -  starting webserver on 'localhost:49274'
15:25:24     INFO -  SUITE-START | Running 2 tests
15:25:24     INFO -  TEST-START | dromaeo_css
15:25:24     INFO -  operating with platform_type : w8_
15:25:24     INFO -  Initialising browser for dromaeo_css test...
15:25:25     INFO -  TEST-INFO | started process 3084 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp7ilzgv\profile http://localhost:49274/getInfo.html)
15:25:33     INFO -  PID 3084 | __metrics	Screen width/height:1600/1200
15:25:33     INFO -  PID 3084 | 	colorDepth:24
15:25:33     INFO -  PID 3084 | 	Browser inner width/height: 1010/676
15:25:33     INFO -  PID 3084 | __metrics
15:25:35     INFO -  PID 3084 | [GPU 1324] 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
15:25:35    ERROR -  PID 3084 | 1490653535128	addons.xpi	WARN	Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///C:/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///C:/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///c:/users/cltbld~1.t-w/appdata/local/temp/tmp7ilzgv/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///c:/users/cltbld~1.t-w/appdata/local/temp/tmp7ilzgv/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///c:/users/cltbld~1.t-w/appdata/local/temp/tmp7ilzgv/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///c:/users/cltbld~1.t-w/appdata/local/temp/tmp7ilzgv/profile/extensions/talos-powers@TalosPowersService.js:55:9
15:25:35    ERROR -  PID 3084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined
15:25:35     INFO -  PID 3084 | [Child 2052] 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
15:25:35     INFO -  PID 3084 | [Child 2052] 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
15:25:35     INFO -  PID 3084 | [Child 3604] 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
15:25:35     INFO -  PID 3084 | [GPU 1324] 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
15:25:35     INFO -  PID 3084 | [GFX1-]: Failed to OpenSharedResource for SyncObjectD3D11: 0x80070057
15:25:35     INFO -  PID 3084 | [GFX1 4]: Without device reset: 0x80070057
15:25:35     INFO -  PID 3084 | console.error:
15:25:35     INFO -  PID 3084 |   Message: Error: Connection closed before committing the transaction.
15:25:35     INFO -  PID 3084 |   Stack:
15:25:35     INFO -  PID 3084 |     executeTransaction/promise</transactionPromise<@resource://gre/modules/Sqlite.jsm:617:19
15:25:35     INFO -  PID 3084 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42
15:25:35     INFO -  PID 3084 | process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:922:23
15:25:35     INFO -  PID 3084 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:806:7
15:25:35     INFO -  PID 3084 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:739:11
15:25:35     INFO -  PID 3084 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:770:7
15:25:35     INFO -  PID 3084 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:707:7
15:25:35     INFO -  PID 3084 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15
15:25:35     INFO -  PID 3084 | observe@resource://gre/modules/AsyncShutdown.jsm:531:9
15:25:35     INFO -  PID 3084 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
15:25:35     INFO -  PID 3084 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:390:5
15:25:35     INFO -  PID 3084 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
15:25:35     INFO -  PID 3084 | trigger@resource://gre/modules/AsyncShutdown.jsm:700:23
15:25:35     INFO -  PID 3084 | _wait@resource://gre/modules/AsyncShutdown.jsm:847:7
15:25:35     INFO -  PID 3084 | wait@resource://gre/modules/AsyncShutdown.jsm:831:28
15:25:35     INFO -  PID 3084 | observe@resource://gre/modules/AsyncShutdown.jsm:514:17
15:25:35     INFO -  PID 3084 |
15:25:36     INFO -  PID 3084 |
15:25:36     INFO -  PID 3084 | ###!!! [Child][MessageChannel::SendAndWait] Error: Channel error: cannot send/recv
15:25:36     INFO -  PID 3084 |
15:25:37     INFO -  TEST-INFO | 3084: exit 0
15:25:37     INFO -  Browser initialized.
15:25:37     INFO -  Running cycle 1/1 for dromaeo_css test...
15:25:37     INFO -  TEST-INFO | started process 3340 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp7ilzgv\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
15:25:38     INFO -  PID 3340 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
15:25:49     INFO -  PID 3340 | RSS: Main: 149102592
15:25:49     INFO -  PID 3340 |
15:28:50     INFO -  PID 3340 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html)
15:28:51     INFO -  PID 3340 | RSS: Main: 132657152
15:28:51     INFO -  PID 3340 |
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | A coding exception was thrown and uncaught in a Task.
15:30:38     INFO -  PID 3340 |
15:30:38    ERROR -  PID 3340 | Full message: TypeError: NetworkError when attempting to fetch resource.
15:30:38     INFO -  PID 3340 | Full stack:
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | A coding exception was thrown and uncaught in a Task.
15:30:38     INFO -  PID 3340 |
15:30:38    ERROR -  PID 3340 | Full message: TypeError: NetworkError when attempting to fetch resource.
15:30:38     INFO -  PID 3340 | Full stack:
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | A coding exception was thrown and uncaught in a Task.
15:30:38     INFO -  PID 3340 |
15:30:38    ERROR -  PID 3340 | Full message: TypeError: NetworkError when attempting to fetch resource.
15:30:38     INFO -  PID 3340 | Full stack:
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | *************************
15:30:38     INFO -  PID 3340 | A coding exception was thrown and uncaught in a Task.
15:30:38     INFO -  PID 3340 |
15:30:38    ERROR -  PID 3340 | Full message: TypeError: NetworkError when attempting to fetch resource.
15:30:38     INFO -  PID 3340 | Full stack:
15:30:38     INFO -  PID 3340 | *************************
15:31:53     INFO -  PID 3340 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html)
15:31:54     INFO -  PID 3340 | RSS: Main: 96759808
15:31:54     INFO -  PID 3340 |
15:34:56     INFO -  PID 3340 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html)
15:34:56     INFO -  PID 3340 | RSS: Main: 100102144
15:34:56     INFO -  PID 3340 |
15:37:58     INFO -  PID 3340 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html)
15:37:59     INFO -  PID 3340 | RSS: Main: 88616960
15:37:59     INFO -  PID 3340 |
15:41:01     INFO -  PID 3340 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html)
15:41:02     INFO -  PID 3340 | RSS: Main: 112279552
15:41:02     INFO -  PID 3340 |
15:44:04     INFO -  PID 3340 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html)
15:44:05     INFO -  PID 3340 | RSS: Main: 93491200
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | __start_tp_report
15:44:05     INFO -  PID 3340 | _x_x_mozilla_page_load
15:44:05     INFO -  PID 3340 | _x_x_mozilla_page_load_details
15:44:05     INFO -  PID 3340 | |i|pagename|runs|
15:44:05     INFO -  PID 3340 | |0;dojo.html;2779.944401111978;2816.183306841016;2832.6317578714766;2839.304370429245;2848.1597928611063;4712.246040633499;4809;4847.587955023827;4851.636127290459;4906.975465122674;4683.9531604684025;4783.760811959397;4848.878778030551;4855.32025516428;4855.417349918015;4362.149380870732;4403.823847046115;4428.158649856517;4484.215262329096;4502.662300327489;4406.933895991563;4441.511433742286;4481.775911204443;4485.865424037268;4504.954950450503;4185.183889141618;4315.762633055181;4331.371951067109;4337.392765012901;4394.62645675118;4404.977975110136;4409.206342858284;4409.4488188976375;4437.4009508716235;4445.377647129372;4366.585174408426;4384.232759267115;4389;4394.143142087294;4430.26900561407;4674.345591617176;4736.786844591968;4746.52534746526;4772.093302272557;4797.976010119927;5122.667026643257;5127.692338459667;5139.665921715076;5175.844724658266;5176.637635365526;5142.125838607446;5144.5369916707305;5148.124818780816;5180.067587834188;5226.451222621646;4629.421322334708;4633.582977532038;4718.9292160617615;4755.881102972453;4757.857264282043;5162.380514338303;5183.274341592105;5200.869978250574;5241.868953276198;5245.895082098413;4826.396700412449;4886.95113048865;5054.469280725544;5055.3428054353435;5096.388433387943;4970.826021089245;4971.651984361132;4972.179590367621;4987.551120399182;4990.8253211137435;4880.341153944243;4952.331435256195;4976.029674213493;4983.975080124576;5012.922221722347;5011.398632164163;5023.623228257895;5128.076946149728;5141.997310524412;5154.046501397179;3377.6115746689447;3400;3401.5748031496064;3434.4848272758786;3439.793612383265;3096.2259435141214;3146.716795488417;3154.5899033125547;3165.398574270881;3178.904632861018;4789.688670236424;4796.976015119972;4798.808047678123;4838.032393521239;4842.903141937141;5126.436092029874;5164.406093299319;5172.793088276427;5181.274621552986;5206.245094461282;4700.858974230779;4728.763561821896;4738.834140805125;4768.284757286366;4824.228123500223;4205.789710514462;4226.154769046203;4298.484181898192;4317.352397140391;4337.0458499130145;5202.115640341227;5211.791528338824;5213.582913366921;5225.843224703265;5247.0030694168745;5167.069927413102;5176.482351764944;5186.325777648882;5191.844244672666;5193.792248310177;5097.719625420637;5130.692158470503;5173.586113110867;5175.611829112756;5178.404483484297;5060.114479965918;5115.948840511547;5119;5149.510796474329;5151.25306830515;5097.8725531862;5138.152204886302;5162.406323272721;5167.095758242368;5189.844304670866;4900.705957642553;4925.088858561177;4967.304577359245;5026.195808670595;5039.596832253337;4924.138275801792;4962.652614316963;4983.8504844854715;5005.4744251853035;5045.066662667418;4789.281607758864;4834.081524510332;4924.285978533164;4930.309756634002;4985.9501404985485;4961.42943561495;4966.528179822911;5005.524475174852;5014.498550145102;5058.721770302669;4814.638902082288;4862.95137048625;4983.07813054586;4988.850334489971;5003.599712023102
15:44:05     INFO -  PID 3340 | |1;ext.html;690.4924880213042;715.4812760748457;738.8152961759558;1160.6402015375234;1175.811870100783;31532.36935261296;31907.36185276293;32096.197595060105;32298.838505807496;32535.186620334473;30891.84554077232;31005.37989240214;31272.061838144837;31282.374352512936;31352.84323578379;6519.934800651992;6647.4017338439535;6894.24163342032;7090.964545177293;7100.218975912646;6966.721331146748;7016.929830701679;7021.36807687308;7082.893756593655;7084.0790697209295;7100.68046937889;7111.146662400519;7121.109861267341;7149.928500714978;7155;7062.293770622922;7076.823079423004;7094.467914906351;7098.609576473292;7103.928960710378;7014.789556313319;7049.929500704979;7050.47121465887;7076.681549330293;7081.822954426129;33376.998690039094;33553.496697549555;33562.1609459763;33774.6622533774;33979.15052123717;2734.2890848379366;2740.643716316866;2749.505089083964;2754.2701184186208;2791.986040069807;23871.283861484182;24064.51870962571;24095.87952060246;24107.638385424234;24671.753282467125;3049.786514943955;3070.7850450468477;3081.506958886567;3088.5212792017273;3146.3078122812944;117910.41044794722;129547;130593.34703326518;154226;154346;36716.81641591775;36723.632763672555;40407;40516.797416012734;40542.79728601338;42046.78976605098;42125.36811947823;42236.15527689429;42245.15509689789;42282.36576451355;11800.645980620424;11847.111466640037;11884.108691848145;11886.465109070112;11912.583059592873;9183.58673859678;9351.018143095012;9362.344635875423;9366.250699943988;9474.668386606436;12757.107002509922;12850.293233872228;12883.29141897186;12884.291363975071;12972.156809807333;5475.479829416199;5483.75323110461;5508.366537848118;5528.778848846082;5530.446955304518;933.9599307444967;953.609020301673;956.2015716876347;961.5240455974338;964.2210122324301;24243.75756242415;24654.506909861702;24912.12807551727;24959.251222463354;25008.124715634865;976.8681228034267;1007.496251874063;1008.1531513528671;1010.5705075343096;1022.3508072374096;11145.777084458428;11253.099752019818;11408.372539510407;11413.42932853354;11520.481578328996;231409;232200;232434;233716;233728;45054.32418513725;45071.77464112658;45320.54679453229;45353.09293814105;45459.545404546196;1266.4934026389333;1319.4458327502473;1332.1074879830344;1334.6596617862383;1337.585348541955;20860.791392086492;20871.478213044797;21403.250886218906;21598.784012160308;21875.12499500002;32009.35981280408;32059.038228853173;32239.35521289608;32245.67754322427;32261.838690806395;224328;225752;226614;227148;230577;28418.71581284161;28647.42705145927;28692.13923582296;29089.854550727112;29264.26839329034;33890.66109338875;34435;34783;34966.47550286697;35439.11402214965;25993.22020339393;26428.603570946834;26619.866900666148;26736.465270694087;27331.86334068317;26057.218283451526;26236.737632624194;26438.603420949086;26648.467030659667;26783.196504104908;30106.84946575253;30174.84912575511;30186.396272074875;30259;30287.697123028487;25702.100426484983;26113.216603501925;26177.869110654327;26334.868325658248;26927.326816829736;21322.147114115884;21748.67376989378;22026.229081982056;22112.33662990113;22145
15:44:05     INFO -  PID 3340 | |2;jquery.html;380.37238556381965;386.4715629393094;391.08291057470234;395.55697618667097;397.80308747170153;18056.90971545142;18632.627347453043;19230.903845480752;19363.515912102186;19433.514162145955;17139.571510712238;17179;17400.82599174008;17444.651106977853;17550.82449175508;5302.337207849019;5316.255724198615;5406.486383793553;5527.060399732055;5527.364353099385;5344.385395679507;5394.865128371783;5446.782128714846;5455.208994695767;5471.124620060791;5214.165733482643;5369.7583608737705;5391.245225668409;5412.431694672062;5425.104857698475;5331.2269720890445;5370.328708911406;5371.57027437804;5383.865403364927;5393.568514518868;4677.602403795681;4819.180739274332;4843.66094373394;4846.0550192712435;4862.270659401082;19927.800721992884;20207.898960505103;21539.138434462602;21592;21753;1566.4047661888524;1645.572151240674;1648.645541208646;1690.7294832826813;1704.701677206484;12870.806937895939;13321.933390333083;13461.865381346159;13602.863971360259;13963.162210267417;1618.2879533005557;1632.4612877750315;1644.8190699023098;1646.218046427949;1656.6603846211497;72654.63672681656;76597.61701191514;76734;76900.91850109342;77884.99999999943;10140.087392134596;10273.229507786946;10299.433531155859;10333.173346132291;10356.223283253787;14240.359183836545;14393.121375724897;14445.349959251858;14446.566603001927;14450.638734031734;6695.598264104169;6790.117284752951;6820.624865632339;6888.758893438706;6914.827129321807;6036.913355596035;6095.908561371583;6222.315545290015;6317.431431171217;6336.651484168323;6675.4325882300545;6799.4900382471515;6811.863762724718;6827.180738311435;6846.760363387258;1978.3867001229378;1980.2178139634764;1995.331563926072;2005.1878989009474;2146.8604540704805;887.973360799177;892.4154678685471;903.5166186090541;907.3331101640289;915.697819719491;16400.343986240656;16744.24650890713;16882.831171688373;17187.226574804165;17247.74128388075;879.5953861223909;889.3685483306796;898.7079199260266;899.9190072893471;914.2366124286162;9198.908010919939;9260.583273752698;9438.764030899283;9490.90509094914;9606.855897161548;361817;364774;365061;365786;366457;79147;80347;80429.99999999884;80538.19461805306;80626;1012.9718335889079;1013.37677328441;1036.6734478639205;1038.7247379444452;1044.8171569975225;13974.720505589628;14046;14257.572272831832;14282.428702852185;14508.85491145075;37601.4359784598;37634.8118259407;37814;37855.24289514139;38375.80812095922;47551.28673069976;48187.5181248183;48314.516854831;49403.752981234866;49426.50573494363;7411.4070874331;7492.288232617892;7785.455018148676;7827.139014708491;7861.213878612093;12335.814962775745;12420.130590858553;12458.501659933501;12547.93726031364;12753.107282490137;9378.577963991773;9409.435433873989;9468.384555003902;9597.9040209597;10101.343412678152;9084.90915090867;9377;9383.01478344764;9411.4823684698;9597.28020398459;9799.85300220483;10005.899941000496;10095.394276343442;10119.696409107739;10171.898281017391;7621.275978782007;7634;7687.38941013774;7824.256695613907;7910.288074073361;9414.811703765748;9421.528923553658;9423.81152376935;9477.859548459524;9633.470159141034
15:44:05     INFO -  PID 3340 | |3;mootools.html;1231.938403079846;1267.4993377615842;1277.0294576122155;1277.6486466221793;1284.755896379688;8340.291075258603;8682.696105636312;8692.348073894467;8715.738527844167;8968.192862642361;8443.915560844389;8547.700830470934;8554.657813687445;8564.443311184768;8596.054434012269;2002.479355367604;2043.111246607723;2063.8968051597435;2064.1330641130685;2067.224790703486;1947.8928658923753;1996.8103030212108;2015.0730663894626;2067.4934641012896;2084.895755212241;2007.7189193512847;2062.535929415877;2065.5868826234814;2069.7102405663218;2070.3064473401355;1951.1414977409966;1978.544934665028;1990.3929301563016;1990.462575104728;1992.203118752496;1630.7064728348892;1673.564873132982;1960.9705854412052;1975.841932645385;1979.5941831924422;8552.486850788973;8730.126987301219;8755.430896991675;8758.386912916098;8785.472871627722;4714.6464015199;4898.436679781835;4899.265110233458;4910.7299098549565;4920.655554111214;2902.492063888832;2973.628296462942;2979.2849716068204;3002.069358498872;3041.680623534541;999.9000099990016;1003.2074661017787;1026.558579810681;1045.231754660324;1054.4885730420817;12281.877181228163;12309.569165079269;12412.069094817925;12459.813102803466;12460.563880264148;3931.272714547818;4056.0671045659665;4103.4870641169855;4104.8768536943935;4105.91788164235;8960.103989600988;8977.596008179647;8980.236679882153;8983.685571004984;8996.325275604357;4635.119327327797;4637.049404871993;4639.86080417588;4651.279051746985;4655.162070827216;4184.267753143248;4258.914821703611;4381.78091095444;4381.978090109529;4543.840965566255;3483.2859263851356;3512.7189824813954;3526.3299973005046;3574.5531808523933;3579.785212887235;940.4639355567261;946.6260826973445;948.3456415073578;949.4493193947494;952.5332587032304;663.1544780405022;664.5481072870398;679.9966000169967;685.5817951049855;686.605202008847;4971.1797553403285;5019.14674505335;5072.847814565569;5077.441481437039;5194.506521880416;827.5448503323148;833.5832083958021;836.3601844588894;839.9874001889976;855.6577369052304;3181.538676891838;3294.341131773655;3298.7855789373616;3327.8169700666695;3369.747268954838;9415.529223538933;9764.267679924034;10577.312474689274;10687.41219232934;11020.283681560673;10798.028177464066;10909.072728818139;10957.232993690364;10976.945115274373;11291.322520648788;7808.804779880548;7999.8400431883065;8010.599470026592;8024.879626805603;8032.317253033558;5116.30929824469;5192.9740351298005;5217.9478205217465;5231.372235331784;5356.223347614652;9187.356885017985;9217.86173207389;9238.122378374044;9259.398139120936;9383;9367;9369.250459963323;9442.15020648145;9476.66831660916;9518.19095376873;6498.902516462163;6588.40704336612;6605.108310378229;6606.603603783596;6616.603003819786;7679.155292917886;7855.5286682799215;7920.841583168189;7922.841543169219;7954.522728636301;6553.901691474727;6597.472202223715;6602.10871532337;6631.900521492278;6649.567778094409;6490.967545162244;6578.111954886029;6598.703058362481;6623.668816559057;6655.367740064686;5760.654360738369;5847.707614619337;5855.2973643163095;5868.354481007001;5873;4343.826246950087;4487.955120448884;4494.70784399013;4506.053728716875;4568.0863827234025;4459.308807134899;4519.661025423172;4525.8189672414055;4541.477730060953;4573.314002899591
15:44:05     INFO -  PID 3340 | |4;prototype.html;349.89503149055287;355.46147586406596;356.98572057117724;365.0435858051901;367.61767761527994;5354.500739792855;5376.4085950545405;5399.865003374917;5424.213489044087;5435.429279925605;5260.579153667697;5287.021900948318;5300.496452836984;5304.92042619361;5306.3632364116265;3818.8281527331196;3994.2211268802594;4010.7794071326066;4040.8585699500377;4078.7960601969785;4035.9394609080887;4036.192761447722;4040.717149799515;4044.130511939932;4044.6764258859366;3983.2830090583684;4017.5982401759884;4024.8591299304385;4025.054112283611;4026.9798651006704;3928.2339943710986;3976.622220889011;3990.2618015666903;4025.8590949316927;4033.6773058155277;3460.584729832436;3481.425564781808;3490.7730997485082;3493.877714279988;3501.28223714138;5081.517255860687;5091.014504343309;5147.305113809625;5161.277421161003;5191.662541934762;4445.488768791565;4587.747673877935;4600.2869555218995;4606.439624771452;4623.260278355447;5449.727513624303;5455.1271796512765;5462.453754624546;5462.9726851365485;5506.64206826555;3757.4739536464917;3770.717196210268;3772.000419888732;3775.528058992626;3788.6590206881237;5214.374275087014;5457.544105152658;5764.106563482667;5765.942340576583;5833.38749431312;3788.1287303920253;3844.7693138411787;3854.075021994757;3907.1013666856215;3912.2762288976633;3929.2514830900545;3943.38877473992;3949.7235193536176;3960.465337179444;3969.54350249725;4575.862724118282;4577.725336479822;4589.10512450069;4602.516735742765;4612.976935115303;5345.919811202835;5384.892302153935;5455.18172274162;5485.341758988947;5513.979913715975;1353.343628340254;1357.9660508487366;1363.2346111785262;1371.3143428285857;1374.113696665665;872.882160908282;900.7387857521377;905.981880362389;906.8005038891433;916.9633214671472;5260.71066091361;5275.472452754694;5276.736163191902;5282.920756188661;5297.231901374279;5537.169424586264;5745.827625171251;5770.922467911549;5771.913421298684;5775.133729940542;5102.081625307406;5227.902794775064;5227.973860130751;5232.9738351308;5256.027634887558;3012.9397412051635;3045.33002739397;3071.232191952012;3071.6467606225124;3080.5687203791485;5778.595498315161;5806.622569532967;5842.707864606753;5853.239078919713;5864.560157988168;5557.221988921554;5825.504832089235;5828.184054232411;5842.707864606753;5850.648961062265;5523.226748255248;5560.972195138998;5699.800506982236;5814.825555233349;5827.5337972961215;5723.195634139159;5775.711214439178;5780.421957804186;5794.362620111869;5813.6221145625395;5549;5608.943910561005;5621.8594535136945;5639.390789894389;5641.633293835887;5760.395158508296;5828.154917536848;5829.300483941955;5836.591438599257;5838.357780644211;3935.763854168759;3942.0539070623418;3943.1127996200626;3944;3956.723029387915;5556.305461817273;5717.542596592346;5722.227499287543;5725.333852910032;5745.425457454388;5537.501624853782;5544.445555444423;5572.275604171432;5577.74900129487;5603.38362780102;5468.48049435303;5518.751656175402;5605.215269862141;5605.551555875439;5610.046292130266;5459.672419654833;5464.316960379952;5467.835964921059;5473.781048758005;5493.587980901529;5550.167474878639;5580.35825880029;5609.775608975595;5618.4662457066515;5619.578531610064;5325.934813037486;5451.155070964007;5457.372402173642;5490.972545137249;5500.697461639648
15:44:05     INFO -  PID 3340 | |5;yui.html;690.872188645101;694.9096617439732;710.9608971506568;721.6536062689909;736.0541703910475;12738;13378.264195469244;13433.462661493553;13489.932550337247;14365.35355908984;13177.143485673449;13394.196348219113;13717.45130194791;13794.517191898285;13816.723665526684;808.3937047214589;833.3458235285302;834.407570624857;835.7283882738104;836.9455985360962;817.1950628630794;817.7342363731811;833.6582001379436;840.1388576708861;843.7679638099511;873.6767396063466;875.8073223890734;882.4352414454722;888.2228050455851;892.9642814287421;869.4261787220436;869.4392117084445;870.0125357718971;870.060334838373;883.3110174064208;646.615263917968;649.5128653509868;650.2099948562519;655.298830251631;661.1174082599736;13730.382132804049;13944;14181;14216.360263788154;14246.145231286157;13357.880333374798;13436.844732900649;13441.66395840102;13523.32383380827;13773.38019789102;10014.54934527948;10382.428966406844;10426.374417534973;10565.41890196039;10613.57545698179;2692.8247771747406;2731.8907243710228;2770.7921905857143;2787.456445993032;2836.3759972806156;55715.16427253594;57730;58537.41462585362;58696.70651646757;59635;9821.754456138511;9945.303828732063;9987.700368988943;10072.244581656405;10213.234007449471;19969.20123195056;20091.095900684504;20265.594688106154;20342.898285508476;20364.69452958207;6698.095757072733;6847.1783385993;6904.551204171713;6907.654617269116;7001.229864714877;3529.364754303072;3539.4690796380232;3587.820608969541;3594.6405359464366;3623.80069096197;3081.506958886612;3150.212446888278;3167.255694911694;3175.9682403176134;3190.4097741917353;601.9488343490852;605.3673910763263;605.4944121658376;614.9300217621307;621.6332363905318;572.4743558416856;575.2320651929721;576.4984463516683;578.1789858401081;587.8500982249499;8182.263596276363;8357.58212089393;8554.144585541397;8583.767684288905;8591.957040214758;540.119605043784;547.8438644986239;548.1366847215651;548.6241924281879;554.6782865937827;3770.7737535747942;4013.1572369802084;4044.838206471708;4068.4100805383055;4145.3781932709735;56072.719636401554;56120;56903.43096569064;58765.11852322218;58891;36828.631713682524;42968.78515607402;46371;47359;48051;42114.36828447576;42772.57227427748;43294.13411731748;43398.783006085396;44214.33678494825;8785.25325347327;8999.685011024583;9055.18503334703;9124.224440922597;9151.450912945245;20369.69445458349;20799.168033279104;21175;21884.89057554766;22133.889330553244;36081.639183607826;36386.45420318644;38478;38688.22623547457;39440.80279598584;11657.358845263592;11796.4691588877;11856.58501952462;11865.940670296593;12343.321117338633;12596.685082873002;12659.430325635185;12855.485780568673;12897.48410063587;13484.86515134836;10754.247202695737;11131.55473781072;11169.218154729091;11586.942065289619;11723.824142638037;11487.597934072268;11493.965543101162;11678.941605291919;11777.646670599896;12235.632931012084;10878.075363594184;11075.612353567587;11439.942800285946;11451.656450306504;11479.36863472517;8000.159564389366;8079;8236.382271329554;8291.046529649167;8525.531095789544;9077.591508382007;9206.447613142966;9880;9898.307118501636;9901.950490247502
15:44:05     INFO -  PID 3340 | __end_tp_report
15:44:05     INFO -  PID 3340 | __start_cc_report
15:44:05     INFO -  PID 3340 | _x_x_mozilla_cycle_collect,373
15:44:05     INFO -  PID 3340 | __end_cc_report
15:44:05     INFO -  PID 3340 | __startTimestamp1490654645099__endTimestamp
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | ------- Summary: start -------
15:44:05     INFO -  PID 3340 | Number of tests: 6
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [#0] dojo.html  Cycles:165  Average:4716.44  Median:4906.98  stddev:579.77 (11.8%)  stddev-sans-first:561.29
15:44:05     INFO -  PID 3340 | Values: 2779.9  2816.2  2832.6  2839.3  2848.2  4712.2  4809.0  4847.6  4851.6  4907.0  4684.0  4783.8  4848.9  4855.3  4855.4  4362.1  4403.8  4428.2  4484.2  4502.7  4406.9  4441.5  4481.8  4485.9  4505.0  4185.2  4315.8  4331.4  4337.4  4394.6  4405.0  4409.2  4409.4  4437.4  4445.4  4366.6  4384.2  4389.0  4394.1  4430.3  4674.3  4736.8  4746.5  4772.1  4798.0  5122.7  5127.7  5139.7  5175.8  5176.6  5142.1  5144.5  5148.1  5180.1  5226.5  4629.4  4633.6  4718.9  4755.9  4757.9  5162.4  5183.3  5200.9  5241.9  5245.9  4826.4  4887.0  5054.5  5055.3  5096.4  4970.8  4971.7  4972.2  4987.6  4990.8  4880.3  4952.3  4976.0  4984.0  5012.9  5011.4  5023.6  5128.1  5142.0  5154.0  3377.6  3400.0  3401.6  3434.5  3439.8  3096.2  3146.7  3154.6  3165.4  3178.9  4789.7  4797.0  4798.8  4838.0  4842.9  5126.4  5164.4  5172.8  5181.3  5206.2  4700.9  4728.8  4738.8  4768.3  4824.2  4205.8  4226.2  4298.5  4317.4  4337.0  5202.1  5211.8  5213.6  5225.8  5247.0  5167.1  5176.5  5186.3  5191.8  5193.8  5097.7  5130.7  5173.6  5175.6  5178.4  5060.1  5115.9  5119.0  5149.5  5151.3  5097.9  5138.2  5162.4  5167.1  5189.8  4900.7  4925.1  4967.3  5026.2  5039.6  4924.1  4962.7  4983.9  5005.5  5045.1  4789.3  4834.1  4924.3  4930.3  4986.0  4961.4  4966.5  5005.5  5014.5  5058.7  4814.6  4863.0  4983.1  4988.9  5003.6
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [#1] ext.html  Cycles:180  Average:33711.78  Median:16668.74  stddev:53193.88 (319.1%)  stddev-sans-first:53285.32
15:44:05     INFO -  PID 3340 | Values: 690.5  715.5  738.8  1160.6  1175.8  31532.4  31907.4  32096.2  32298.8  32535.2  30891.8  31005.4  31272.1  31282.4  31352.8  6519.9  6647.4  6894.2  7091.0  7100.2  6966.7  7016.9  7021.4  7082.9  7084.1  7100.7  7111.1  7121.1  7149.9  7155.0  7062.3  7076.8  7094.5  7098.6  7103.9  7014.8  7049.9  7050.5  7076.7  7081.8  33377.0  33553.5  33562.2  33774.7  33979.2  2734.3  2740.6  2749.5  2754.3  2792.0  23871.3  24064.5  24095.9  24107.6  24671.8  3049.8  3070.8  3081.5  3088.5  3146.3  117910.4  129547.0  130593.3  154226.0  154346.0  36716.8  36723.6  40407.0  40516.8  40542.8  42046.8  42125.4  42236.2  42245.2  42282.4  11800.6  11847.1  11884.1  11886.5  11912.6  9183.6  9351.0  9362.3  9366.3  9474.7  12757.1  12850.3  12883.3  12884.3  12972.2  5475.5  5483.8  5508.4  5528.8  5530.4  934.0  953.6  956.2  961.5  964.2  24243.8  24654.5  24912.1  24959.3  25008.1  976.9  1007.5  1008.2  1010.6  1022.4  11145.8  11253.1  11408.4  11413.4  11520.5  231409.0  232200.0  232434.0  233716.0  233728.0  45054.3  45071.8  45320.5  45353.1  45459.5  1266.5  1319.4  1332.1  1334.7  1337.6  20860.8  20871.5  21403.3  21598.8  21875.1  32009.4  32059.0  32239.4  32245.7  32261.8  224328.0  225752.0  226614.0  227148.0  230577.0  28418.7  28647.4  28692.1  29089.9  29264.3  33890.7  34435.0  34783.0  34966.5  35439.1  25993.2  26428.6  26619.9  26736.5  27331.9  26057.2  26236.7  26438.6  26648.5  26783.2  30106.8  30174.8  30186.4  30259.0  30287.7  25702.1  26113.2  26177.9  26334.9  26927.3  21322.1  21748.7  22026.2  22112.3  22145.0
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [#2] jquery.html  Cycles:180  Average:24017.08  Median:4844.86  stddev:60591.14 (1250.6%)  stddev-sans-first:60735.12
15:44:05     INFO -  PID 3340 | Values: 380.4  386.5  391.1  395.6  397.8  18056.9  18632.6  19230.9  19363.5  19433.5  17139.6  17179.0  17400.8  17444.7  17550.8  5302.3  5316.3  5406.5  5527.1  5527.4  5344.4  5394.9  5446.8  5455.2  5471.1  5214.2  5369.8  5391.2  5412.4  5425.1  5331.2  5370.3  5371.6  5383.9  5393.6  4677.6  4819.2  4843.7  4846.1  4862.3  19927.8  20207.9  21539.1  21592.0  21753.0  1566.4  1645.6  1648.6  1690.7  1704.7  12870.8  13321.9  13461.9  13602.9  13963.2  1618.3  1632.5  1644.8  1646.2  1656.7  72654.6  76597.6  76734.0  76900.9  77885.0  10140.1  10273.2  10299.4  10333.2  10356.2  14240.4  14393.1  14445.3  14446.6  14450.6  6695.6  6790.1  6820.6  6888.8  6914.8  6036.9  6095.9  6222.3  6317.4  6336.7  6675.4  6799.5  6811.9  6827.2  6846.8  1978.4  1980.2  1995.3  2005.2  2146.9  888.0  892.4  903.5  907.3  915.7  16400.3  16744.2  16882.8  17187.2  17247.7  879.6  889.4  898.7  899.9  914.2  9198.9  9260.6  9438.8  9490.9  9606.9  361817.0  364774.0  365061.0  365786.0  366457.0  79147.0  80347.0  80430.0  80538.2  80626.0  1013.0  1013.4  1036.7  1038.7  1044.8  13974.7  14046.0  14257.6  14282.4  14508.9  37601.4  37634.8  37814.0  37855.2  38375.8  47551.3  48187.5  48314.5  49403.8  49426.5  7411.4  7492.3  7785.5  7827.1  7861.2  12335.8  12420.1  12458.5  12547.9  12753.1  9378.6  9409.4  9468.4  9597.9  10101.3  9084.9  9377.0  9383.0  9411.5  9597.3  9799.9  10005.9  10095.4  10119.7  10171.9  7621.3  7634.0  7687.4  7824.3  7910.3  9414.8  9421.5  9423.8  9477.9  9633.5
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [#3] mootools.html  Cycles:180  Average:5290.79  Median:4915.69  stddev:3229.75 (65.7%)  stddev-sans-first:3224.41
15:44:05     INFO -  PID 3340 | Values: 1231.9  1267.5  1277.0  1277.6  1284.8  8340.3  8682.7  8692.3  8715.7  8968.2  8443.9  8547.7  8554.7  8564.4  8596.1  2002.5  2043.1  2063.9  2064.1  2067.2  1947.9  1996.8  2015.1  2067.5  2084.9  2007.7  2062.5  2065.6  2069.7  2070.3  1951.1  1978.5  1990.4  1990.5  1992.2  1630.7  1673.6  1961.0  1975.8  1979.6  8552.5  8730.1  8755.4  8758.4  8785.5  4714.6  4898.4  4899.3  4910.7  4920.7  2902.5  2973.6  2979.3  3002.1  3041.7  999.9  1003.2  1026.6  1045.2  1054.5  12281.9  12309.6  12412.1  12459.8  12460.6  3931.3  4056.1  4103.5  4104.9  4105.9  8960.1  8977.6  8980.2  8983.7  8996.3  4635.1  4637.0  4639.9  4651.3  4655.2  4184.3  4258.9  4381.8  4382.0  4543.8  3483.3  3512.7  3526.3  3574.6  3579.8  940.5  946.6  948.3  949.4  952.5  663.2  664.5  680.0  685.6  686.6  4971.2  5019.1  5072.8  5077.4  5194.5  827.5  833.6  836.4  840.0  855.7  3181.5  3294.3  3298.8  3327.8  3369.7  9415.5  9764.3  10577.3  10687.4  11020.3  10798.0  10909.1  10957.2  10976.9  11291.3  7808.8  7999.8  8010.6  8024.9  8032.3  5116.3  5193.0  5217.9  5231.4  5356.2  9187.4  9217.9  9238.1  9259.4  9383.0  9367.0  9369.3  9442.2  9476.7  9518.2  6498.9  6588.4  6605.1  6606.6  6616.6  7679.2  7855.5  7920.8  7922.8  7954.5  6553.9  6597.5  6602.1  6631.9  6649.6  6491.0  6578.1  6598.7  6623.7  6655.4  5760.7  5847.7  5855.3  5868.4  5873.0  4343.8  4488.0  4494.7  4506.1  4568.1  4459.3  4519.7  4525.8  4541.5  4573.3
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [#4] prototype.html  Cycles:180  Average:4618.80  Median:5316.15  stddev:1386.59 (26.1%)  stddev-sans-first:1352.95
15:44:05     INFO -  PID 3340 | Values: 349.9  355.5  357.0  365.0  367.6  5354.5  5376.4  5399.9  5424.2  5435.4  5260.6  5287.0  5300.5  5304.9  5306.4  3818.8  3994.2  4010.8  4040.9  4078.8  4035.9  4036.2  4040.7  4044.1  4044.7  3983.3  4017.6  4024.9  4025.1  4027.0  3928.2  3976.6  3990.3  4025.9  4033.7  3460.6  3481.4  3490.8  3493.9  3501.3  5081.5  5091.0  5147.3  5161.3  5191.7  4445.5  4587.7  4600.3  4606.4  4623.3  5449.7  5455.1  5462.5  5463.0  5506.6  3757.5  3770.7  3772.0  3775.5  3788.7  5214.4  5457.5  5764.1  5765.9  5833.4  3788.1  3844.8  3854.1  3907.1  3912.3  3929.3  3943.4  3949.7  3960.5  3969.5  4575.9  4577.7  4589.1  4602.5  4613.0  5345.9  5384.9  5455.2  5485.3  5514.0  1353.3  1358.0  1363.2  1371.3  1374.1  872.9  900.7  906.0  906.8  917.0  5260.7  5275.5  5276.7  5282.9  5297.2  5537.2  5745.8  5770.9  5771.9  5775.1  5102.1  5227.9  5228.0  5233.0  5256.0  3012.9  3045.3  3071.2  3071.6  3080.6  5778.6  5806.6  5842.7  5853.2  5864.6  5557.2  5825.5  5828.2  5842.7  5850.6  5523.2  5561.0  5699.8  5814.8  5827.5  5723.2  5775.7  5780.4  5794.4  5813.6  5549.0  5608.9  5621.9  5639.4  5641.6  5760.4  5828.2  5829.3  5836.6  5838.4  3935.8  3942.1  3943.1  3944.0  3956.7  5556.3  5717.5  5722.2  5725.3  5745.4  5537.5  5544.4  5572.3  5577.7  5603.4  5468.5  5518.8  5605.2  5605.6  5610.0  5459.7  5464.3  5467.8  5473.8  5493.6  5550.2  5580.4  5609.8  5618.5  5619.6  5325.9  5451.2  5457.4  5491.0  5500.7
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [#5] yui.html  Cycles:180  Average:13291.13  Median:43131.46  stddev:15415.96 (35.7%)  stddev-sans-first:15430.16
15:44:05     INFO -  PID 3340 | Values: 690.9  694.9  711.0  721.7  736.1  12738.0  13378.3  13433.5  13489.9  14365.4  13177.1  13394.2  13717.5  13794.5  13816.7  808.4  833.3  834.4  835.7  836.9  817.2  817.7  833.7  840.1  843.8  873.7  875.8  882.4  888.2  893.0  869.4  869.4  870.0  870.1  883.3  646.6  649.5  650.2  655.3  661.1  13730.4  13944.0  14181.0  14216.4  14246.1  13357.9  13436.8  13441.7  13523.3  13773.4  10014.5  10382.4  10426.4  10565.4  10613.6  2692.8  2731.9  2770.8  2787.5  2836.4  55715.2  57730.0  58537.4  58696.7  59635.0  9821.8  9945.3  9987.7  10072.2  10213.2  19969.2  20091.1  20265.6  20342.9  20364.7  6698.1  6847.2  6904.6  6907.7  7001.2  3529.4  3539.5  3587.8  3594.6  3623.8  3081.5  3150.2  3167.3  3176.0  3190.4  601.9  605.4  605.5  614.9  621.6  572.5  575.2  576.5  578.2  587.9  8182.3  8357.6  8554.1  8583.8  8592.0  540.1  547.8  548.1  548.6  554.7  3770.8  4013.2  4044.8  4068.4  4145.4  56072.7  56120.0  56903.4  58765.1  58891.0  36828.6  42968.8  46371.0  47359.0  48051.0  42114.4  42772.6  43294.1  43398.8  44214.3  8785.3  8999.7  9055.2  9124.2  9151.5  20369.7  20799.2  21175.0  21884.9  22133.9  36081.6  36386.5  38478.0  38688.2  39440.8  11657.4  11796.5  11856.6  11865.9  12343.3  12596.7  12659.4  12855.5  12897.5  13484.9  10754.2  11131.6  11169.2  11586.9  11723.8  11487.6  11494.0  11678.9  11777.6  12235.6  10878.1  11075.6  11439.9  11451.7  11479.4  8000.2  8079.0  8236.4  8291.0  8525.5  9077.6  9206.4  9880.0  9898.3  9902.0
15:44:05     INFO -  PID 3340 | -------- Summary: end --------
15:44:05     INFO -  PID 3340 |
15:44:05     INFO -  PID 3340 | [GPU 2300] 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
15:44:05     INFO -  PID 3340 | [GPU 2300] 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
15:44:05     INFO -  PID 3340 | [Child 3784] 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
15:44:05     INFO -  PID 3340 | [Child 3784] 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
15:44:05     INFO -  TEST-INFO | 3340: exit 0
15:44:05     INFO -  mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.crashreporter-symbols.zip
15:44:10     INFO -  mozcrash Copy/paste: C:\slave\test\build\win32-minidump_stackwalk.exe c:\users\cltbld~1.t-w\appdata\local\temp\tmp7ilzgv\profile\minidumps\12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp c:\users\cltbld~1.t-w\appdata\local\temp\tmpexqxew
15:44:10     INFO -  mozcrash Saved minidump as C:\slave\test\build\blobber_upload_dir\12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp
15:44:11     INFO -  PROCESS-CRASH | dromaeo_css | application crashed [unknown top frame]
15:44:11     INFO -  Crash dump filename: c:\users\cltbld~1.t-w\appdata\local\temp\tmp7ilzgv\profile\minidumps\12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp
15:44:11     INFO -  stderr from minidump_stackwalk:
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4359: INFO: Minidump opened minidump c:\users\cltbld~1.t-w\appdata\local\temp\tmp7ilzgv\profile\minidumps\12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4479: INFO: Minidump not byte-swapping minidump
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 15 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 7 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 7 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 1197932545 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 6 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 1197932546 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 4 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 5 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4956: INFO: GetStream: type 3 not present
15:44:11     INFO -  2017-03-27 15:44:10: minidump_processor.cc:152: ERROR: Minidump c:\users\cltbld~1.t-w\appdata\local\temp\tmp7ilzgv\profile\minidumps\12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp has no thread list
15:44:11     INFO -  2017-03-27 15:44:10: stackwalk.cc:139: ERROR: MinidumpProcessor::Process failed
15:44:11     INFO -  2017-03-27 15:44:10: minidump.cc:4331: INFO: Minidump closing minidump
15:44:11     INFO -  minidump_stackwalk exited with return code 1
15:44:11     INFO -  TEST-UNEXPECTED-ERROR | dromaeo_css | Found crashes after test run, terminating test
15:44:11    ERROR -  Traceback (most recent call last):
15:44:11     INFO -    File "C:\slave\test\build\tests\talos\talos\run_tests.py", line 202, in run_tests
15:44:11     INFO -      talos_results.add(mytest.runTest(browser_config, test))
15:44:11     INFO -    File "C:\slave\test\build\tests\talos\talos\ttest.py", line 70, in runTest
15:44:11     INFO -      return self._runTest(browser_config, test_config, setup)
15:44:11     INFO -    File "C:\slave\test\build\tests\talos\talos\ttest.py", line 243, in _runTest
15:44:11     INFO -      test_config['name'])
15:44:11     INFO -    File "C:\slave\test\build\tests\talos\talos\ttest.py", line 47, in check_for_crashes
15:44:11     INFO -      raise TalosCrash("Found crashes after test run, terminating test")
15:44:11     INFO -  TalosCrash: Found crashes after test run, terminating test
15:44:11     INFO -  TEST-INFO took 1126312ms
15:44:11     INFO -  SUITE-END | took 1126s
15:44:11    ERROR - Return code: 2
15:44:11  WARNING - setting return code to 2
15:44:11    ERROR - # TBPL FAILURE #
15:44:11     INFO - Running post-action listener: _resource_record_post_action
15:44:11     INFO - [mozharness: 2017-03-27 22:44:11.669000Z] Finished run-tests step (success)
15:44:11     INFO - Running post-run listener: _resource_record_post_run
15:44:11     INFO - Total resource usage - Wall time: 1131s; CPU: 14.0%; Read bytes: 212605440; Write bytes: 263349248; Read time: 3490690; Write time: 2626650
15:44:11     INFO - TinderboxPrint: CPU usage<br/>13.7%
15:44:11     INFO - TinderboxPrint: I/O read bytes / time<br/>212,605,440 / 3,490,690
15:44:11     INFO - TinderboxPrint: I/O write bytes / time<br/>263,349,248 / 2,626,650
15:44:11     INFO - TinderboxPrint: CPU idle<br/>7,799.3 (86.3%)
15:44:11     INFO - TinderboxPrint: CPU user<br/>1,197.8 (13.2%)
15:44:11     INFO - install - Wall time: 2s; CPU: 10.0%; Read bytes: 0; Write bytes: 54821888; Read time: 0; Write time: 94520
15:44:11     INFO - run-tests - Wall time: 1129s; CPU: 14.0%; Read bytes: 212605440; Write bytes: 197890048; Read time: 3490690; Write time: 2524730
15:44:12     INFO - Running post-run listener: _upload_blobber_files
15:44:12     INFO - Blob upload gear active.
15:44:12     INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
15:44:12     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
15:44:12     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']
15:44:12     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
15:44:12     INFO -  (blobuploader) - INFO - Open directory for files ...
15:44:12     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp ...
15:44:12     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:44:12     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
15:44:13     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b82c42d4441b0b2ba092c66a047ece5f2d545c58ca5ab42cf2f8677309d189b83d988bd32d5cb224135f08da54672a870c1c637c13309aec294f017394116d2'>12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp</a>: uploaded
15:44:13     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:44:13     INFO -  (blobuploader) - INFO - Done attempting.
15:44:13     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log ...
15:44:13     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:44:13     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
15:44:14     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19bc65927a86be8b1f4f6acbf5d56819619a73df11816f025002222f8624b3226a5417d5a6eb85d5400d841c9ab23abd6f0319d3f3f8040dae533e8b7b1b2c6d'>dromaeojs-e10s_errorsummary.log</a>: uploaded
15:44:14     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:44:14     INFO -  (blobuploader) - INFO - Done attempting.
15:44:14     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log ...
15:44:14     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:44:14     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
15:44:15     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bb8dc553c1b64f9d0b33b16c27db04d4200bb9d09bbbb53a7ee66196934c918907e99fdd00c258bc6b440accf786647d5bbeef66a7561065f283bcf75d92f7a'>dromaeojs-e10s_raw.log</a>: uploaded
15:44:15     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:44:15     INFO -  (blobuploader) - INFO - Done attempting.
15:44:15     INFO -  (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
15:44:15     INFO -  (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:44:15     INFO -  (blobuploader) - INFO - Uploading, attempt #1.
15:44:17     INFO -  (blobuploader) - INFO - TinderboxPrint: <a href='http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86d27b19a62e8c05890b29d2e4fb98db9a51a7b93cd1ddc56a71c8c7b65c560c414587d9a18701e7528c0affb5426f2506657a98f5485cfe72466ca2ad645462'>resource-usage.json</a>: uploaded
15:44:17     INFO -  (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:44:17     INFO -  (blobuploader) - INFO - Done attempting.
15:44:17     INFO -  (blobuploader) - INFO - Iteration through files over.
15:44:17     INFO - Return code: 0
15:44:17     INFO - rmtree: C:\slave\test\build\uploaded_files.json
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
15:44:17     INFO - Setting buildbot property blobber_files to {"12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b82c42d4441b0b2ba092c66a047ece5f2d545c58ca5ab42cf2f8677309d189b83d988bd32d5cb224135f08da54672a870c1c637c13309aec294f017394116d2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19bc65927a86be8b1f4f6acbf5d56819619a73df11816f025002222f8624b3226a5417d5a6eb85d5400d841c9ab23abd6f0319d3f3f8040dae533e8b7b1b2c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bb8dc553c1b64f9d0b33b16c27db04d4200bb9d09bbbb53a7ee66196934c918907e99fdd00c258bc6b440accf786647d5bbeef66a7561065f283bcf75d92f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86d27b19a62e8c05890b29d2e4fb98db9a51a7b93cd1ddc56a71c8c7b65c560c414587d9a18701e7528c0affb5426f2506657a98f5485cfe72466ca2ad645462"}
15:44:17     INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
15:44:17     INFO - Writing to file C:\slave\test\properties\blobber_files
15:44:17     INFO - Contents:
15:44:17     INFO -  blobber_files:{"12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b82c42d4441b0b2ba092c66a047ece5f2d545c58ca5ab42cf2f8677309d189b83d988bd32d5cb224135f08da54672a870c1c637c13309aec294f017394116d2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19bc65927a86be8b1f4f6acbf5d56819619a73df11816f025002222f8624b3226a5417d5a6eb85d5400d841c9ab23abd6f0319d3f3f8040dae533e8b7b1b2c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bb8dc553c1b64f9d0b33b16c27db04d4200bb9d09bbbb53a7ee66196934c918907e99fdd00c258bc6b440accf786647d5bbeef66a7561065f283bcf75d92f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86d27b19a62e8c05890b29d2e4fb98db9a51a7b93cd1ddc56a71c8c7b65c560c414587d9a18701e7528c0affb5426f2506657a98f5485cfe72466ca2ad645462"}
15:44:17     INFO - Running post-run listener: copy_logs_to_upload_dir
15:44:17     INFO - Copying logs to upload dir...
15:44:17     INFO - mkdir: C:\slave\test\build\upload\logs
15:44:17     INFO - Copying logs to upload dir...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17     INFO - Using _rmtree_windows ...
15:44:17  WARNING - returning nonzero exit status 2
program finished with exit code 2
elapsedTime=1393.011000
========= master_lag: -0.62 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 23 mins, 12 secs) (at 2017-03-27 15:44:17.378625) =========

========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 15:44:17.385153) =========
'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-084\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-084
  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-084
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local
  LOGONSERVER=\\T-W864-IX-084
  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-084
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-084
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
blobber_files:{"12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b82c42d4441b0b2ba092c66a047ece5f2d545c58ca5ab42cf2f8677309d189b83d988bd32d5cb224135f08da54672a870c1c637c13309aec294f017394116d2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19bc65927a86be8b1f4f6acbf5d56819619a73df11816f025002222f8624b3226a5417d5a6eb85d5400d841c9ab23abd6f0319d3f3f8040dae533e8b7b1b2c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bb8dc553c1b64f9d0b33b16c27db04d4200bb9d09bbbb53a7ee66196934c918907e99fdd00c258bc6b440accf786647d5bbeef66a7561065f283bcf75d92f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86d27b19a62e8c05890b29d2e4fb98db9a51a7b93cd1ddc56a71c8c7b65c560c414587d9a18701e7528c0affb5426f2506657a98f5485cfe72466ca2ad645462"}
build_url:https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/OmbzQUwJQfKWFk1oYBnJkg/artifacts/public/build/firefox-55.0a1.en-US.win64.zip'
blobber_files: '{"12ef3f8a-e7aa-426f-9ca7-b8fdc829d8af.dmp": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b82c42d4441b0b2ba092c66a047ece5f2d545c58ca5ab42cf2f8677309d189b83d988bd32d5cb224135f08da54672a870c1c637c13309aec294f017394116d2", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/19bc65927a86be8b1f4f6acbf5d56819619a73df11816f025002222f8624b3226a5417d5a6eb85d5400d841c9ab23abd6f0319d3f3f8040dae533e8b7b1b2c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bb8dc553c1b64f9d0b33b16c27db04d4200bb9d09bbbb53a7ee66196934c918907e99fdd00c258bc6b440accf786647d5bbeef66a7561065f283bcf75d92f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86d27b19a62e8c05890b29d2e4fb98db9a51a7b93cd1ddc56a71c8c7b65c560c414587d9a18701e7528c0affb5426f2506657a98f5485cfe72466ca2ad645462"}'
========= master_lag: 0.03 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 15:44:17.514133) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:44:17.514868) =========
'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-084\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-084
  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-084
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local
  LOGONSERVER=\\T-W864-IX-084
  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-084
  USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld.T-W864-IX-084
  WINDIR=C:\windows
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
program finished with exit code 0
elapsedTime=0.100000
========= master_lag: 0.03 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:44:17.640752) =========

========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-03-27 15:44:17.641081) =========

========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2017-03-27 15:44:18.368379) =========

========= Total master_lag: -0.42 =========